Apr 04 03:03:00 volumio wpa_supplicant[1135]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="DSDK"
Apr 04 03:03:01 volumio volumio[26995]: info: Loading plugin "calmradio"...
Apr 04 03:03:02 volumio volumio[26995]: info: Loading plugin "soundcloud"...
Apr 04 03:03:03 volumio volumio[26995]: info: Loading plugin "squeezelite_mc"...
Apr 04 03:03:03 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:03.500+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:60942->127.0.0.1:3000: i/o timeout"
Apr 04 03:03:04 volumio volumio[26995]: info: Loading plugin "SleepWakePlugin"...
Apr 04 03:03:04 volumio volumio[26995]: info: Applying required configuration parameters for plugin SleepWakePlugin
Apr 04 03:03:04 volumio volumio[26995]: info: SleepWakePlugin - onVolumioStart
Apr 04 03:03:04 volumio volumio[26995]: info: Loading plugin "outputs"...
Apr 04 03:03:04 volumio volumio[26995]: info: Loading plugin "albumart"...
Apr 04 03:03:04 volumio volumio[26995]: info: Plugin example_plugin is not enabled
Apr 04 03:03:04 volumio volumio[26995]: info: Loading plugin "inputs"...
Apr 04 03:03:04 volumio volumio[26995]: info: Loading plugin "updater_comm"...
Apr 04 03:03:04 volumio volumio[26995]: info: Plugin mpdemulation is not enabled
Apr 04 03:03:04 volumio volumio[26995]: info: Loading plugin "rest_api"...
Apr 04 03:03:04 volumio volumio[26995]: info: Loading plugin "websocket"...
Apr 04 03:03:04 volumio volumio[26995]: info: Starting Socket.io Server version 1.7.4
Apr 04 03:03:04 volumio volumio[26995]: info: Loading plugin "fusiondsp"...
Apr 04 03:03:05 volumio volumio[27059]: Forking 3 albumart workers
Apr 04 03:03:05 volumio volumio[26995]: info: Applying required configuration parameters for plugin fusiondsp
Apr 04 03:03:05 volumio volumio[26995]: info: Loading plugin "mpdoutput"...
Apr 04 03:03:05 volumio volumio[26995]: info: Loading plugin "80s80s"...
Apr 04 03:03:06 volumio volumio[26995]: info: Applying required configuration parameters for plugin 80s80s
Apr 04 03:03:06 volumio volumio[26995]: info: [1775264586248] [80s80s] API delay: 30
Apr 04 03:03:06 volumio volumio[26995]: info: Loading plugin "RoonBridge"...
Apr 04 03:03:06 volumio volumio[26995]: info: Applying required configuration parameters for plugin RoonBridge
Apr 04 03:03:06 volumio volumio[26995]: info: Loading plugin "motherearthradio"...
Apr 04 03:03:06 volumio volumio[27071]: Starting albumart workers
Apr 04 03:03:06 volumio wpa_supplicant[1135]: wlan0: Failed to initiate sched scan
Apr 04 03:03:06 volumio volumio[27069]: Starting albumart workers
Apr 04 03:03:06 volumio volumio[27070]: Starting albumart workers
Apr 04 03:03:06 volumio volumio[26995]: info: Applying required configuration parameters for plugin motherearthradio
Apr 04 03:03:06 volumio volumio[26995]: info: [1775264586820] [MotherEarth] API delay: 5
Apr 04 03:03:06 volumio volumio[26995]: info: Loading plugin "radio_paradise"...
Apr 04 03:03:07 volumio volumio[26995]: info: Applying required configuration parameters for plugin radio_paradise
Apr 04 03:03:07 volumio volumio[26995]: info: [1775264587195] [RadioParadise] API delay: 5
Apr 04 03:03:07 volumio volumio[26995]: info: Loading plugin "rtlsdr_radio"...
Apr 04 03:03:07 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:07.736+02:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded"
Apr 04 03:03:07 volumio volumio-remote-updater[736]: [2026-04-04 03:03:07] [connect] Successful connection
Apr 04 03:03:07 volumio volumio[26995]: info: Loading i18n strings for locale it
Apr 04 03:03:08 volumio volumio[26995]: Updating browse sources language
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::initPlayerControls
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: Express server listening on port 3000
Apr 04 03:03:08 volumio volumio[26995]: [Metrics] WebUI: 15s 234.02ms
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::resetVolumioState
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::getcurrentVolume
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:08 volumio volumio[26995]: info: Cannot mount NAS DJA at system boot, trial number 2 ,retrying in 5 seconds
Apr 04 03:03:08 volumio sudo[27136]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 03:03:08 volumio sudo[27136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:08 volumio sudo[27136]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:08 volumio sudo[27138]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 03:03:08 volumio sudo[27138]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:08 volumio sudo[27138]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:08 volumio volumio[26995]: info: Volumio Network Manager: Network status updated: 0
Apr 04 03:03:08 volumio volumio[26995]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::pushState
Apr 04 03:03:08 volumio volumio[26995]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::updateTrackBlock
Apr 04 03:03:08 volumio volumio[26995]: info: CorePlayQueue::getTrackBlock
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: Reloading queue from file
Apr 04 03:03:08 volumio volumio[26995]: 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
Apr 04 03:03:08 volumio volumio[26995]: info: Setting Device type: Raspberry PI
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::setRepeat false single undefined
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::pushState
Apr 04 03:03:08 volumio volumio[26995]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::setRandom undefined
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::pushState
Apr 04 03:03:08 volumio volumio[26995]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:08 volumio volumio-remote-updater[736]: [2026-04-04 03:03:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1775264587 101
Apr 04 03:03:08 volumio volumio[26995]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 1
Apr 04 03:03:08 volumio volumio[26995]: info: Completed loading Core Plugins
Apr 04 03:03:08 volumio volumio[26995]: info: Preparing to generate the ALSA configuration file
Apr 04 03:03:08 volumio volumio[26995]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 04 03:03:08 volumio volumio[26995]: info: Reading ALSA contributions from plugins.
Apr 04 03:03:08 volumio volumio[26995]: 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: 2
Apr 04 03:03:08 volumio volumio[26995]: 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: 2
Apr 04 03:03:08 volumio volumio[26995]: info: Received Get System Info
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 04 03:03:08 volumio volumio[26995]: info: Discovery: Getting this device information
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioGetState
Apr 04 03:03:08 volumio volumio[26995]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 04 03:03:08 volumio sudo[27152]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 04 03:03:08 volumio sudo[27152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:08 volumio volumio[26995]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:08 volumio volumio[26995]: info: CoreStateMachine::pushState
Apr 04 03:03:08 volumio volumio[26995]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:08 volumio sudo[27152]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 04 03:03:08 volumio volumio[26995]: info: Discovery: adding c69f8783-26e2-48e2-a8ae-e3cb917f598f
Apr 04 03:03:08 volumio volumio[26995]: info: Discovery: Found device Volumio
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioGetState
Apr 04 03:03:08 volumio volumio[26995]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:08 volumio volumio[26995]: info: Upmpdcli Daemon Started
Apr 04 03:03:08 volumio volumio[26995]: info: Asound.conf file unchanged, so no further update is needed
Apr 04 03:03:08 volumio volumio[26995]: info: Output device has changed, restarting MPD
Apr 04 03:03:08 volumio volumio[26995]: info: Output device has changed, restarting Shairport Sync
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:08 volumio sudo[27155]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 03:03:08 volumio sudo[27155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:08 volumio sudo[27155]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:08 volumio sudo[27157]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 03:03:08 volumio sudo[27157]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:08 volumio volumio[26995]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:08 volumio volumio[26995]: info: ___________ START PLUGINS ___________
Apr 04 03:03:08 volumio volumio[26995]: info: ControllerMpd::onStart: Initializing MPD
Apr 04 03:03:08 volumio volumio[26995]: info: Creating MPD Configuration file
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:08 volumio volumio[26995]: info: [1775264588932] CoreMusicLibrary::Adding element Server multimediali
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:08 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Apr 04 03:03:08 volumio sudo[27165]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Apr 04 03:03:08 volumio volumio[26995]: info: UPNP Browser: Client initialized successfully
Apr 04 03:03:08 volumio sudo[27165]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:08 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:08 volumio sudo[27169]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 03:03:08 volumio sudo[27169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:08 volumio sudo[27167]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 03:03:08 volumio sudo[27167]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:08 volumio sudo[27167]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:09 volumio volumio[26995]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:09 volumio sudo[27165]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:09 volumio volumio[26995]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589039] CoreMusicLibrary::Adding element Last_100
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589044] CoreMusicLibrary::Adding element Webradio
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:09 volumio volumio[26995]: info: Initializing BBC Radios
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589132] CoreMusicLibrary::Adding element Bandcamp Discover
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:09 volumio volumio[26995]: info: Adding Calm Radio to Browse Sources
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589139] CoreMusicLibrary::Adding element Calm Radio
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Calm Radio
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589155] CoreMusicLibrary::Adding element SoundCloud
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Calm Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source SoundCloud
Apr 04 03:03:09 volumio volumio[26995]: info: [squeezelite_mc] Starting proxy server...
Apr 04 03:03:09 volumio volumio[26995]: info: SleepWakePlugin - onStart
Apr 04 03:03:09 volumio volumio[26995]: info: SleepWakePlugin - Sleep scheduled in 79010797 milliseconds
Apr 04 03:03:09 volumio volumio[26995]: info: SleepWakePlugin - Wake scheduled in 14210793 milliseconds
Apr 04 03:03:09 volumio volumio[26995]: info: FusionDsp - CamillaDSP binary found.
Apr 04 03:03:09 volumio volumio[26995]: info: Loading i18n strings for locale it
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:09 volumio volumio[26995]: info: FusionDsp - mixtype--------------------- Hardware
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589293] CoreMusicLibrary::Adding element 80s80s Radio
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Calm Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source SoundCloud
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589318] CoreMusicLibrary::Adding element Mother Earth Radio
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Calm Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source SoundCloud
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589330] CoreMusicLibrary::Adding element Radio Paradise
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Calm Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source SoundCloud
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Radio Paradise
Apr 04 03:03:09 volumio sudo[27195]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Apr 04 03:03:09 volumio sudo[27195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Starting plugin
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Loaded i18n strings for language: it
Apr 04 03:03:09 volumio volumio[26995]: info: Volumio Calling Home
Apr 04 03:03:09 volumio sudo[27195]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:09 volumio volumio[26995]: info: [squeezelite_mc] Proxy server started on port 43057
Apr 04 03:03:09 volumio volumio[26995]: info: Preparing to generate the ALSA configuration file
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] snd-aloop already loaded
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Database version: 2
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Loaded v2 database successfully
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Database loaded at: 2026-04-04T01:03:09.554Z
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Loading blocklist from: /data/plugins/music_service/rtlsdr_radio/blocklist.json
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Got 21 phrases from file
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Updated metadata blocklist
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Metadata module now has 21 phrases
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Management server started on port 3456
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:09 volumio volumio[26995]: info: [1775264589840] CoreMusicLibrary::Adding element FM/DAB Radio
Apr 04 03:03:09 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Calm Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source SoundCloud
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source Radio Paradise
Apr 04 03:03:09 volumio volumio[26995]: Cannot find translation for source FM/DAB Radio
Apr 04 03:03:09 volumio volumio[26995]: info: [RTL-SDR Radio] Plugin started successfully
Apr 04 03:03:10 volumio systemd[1]: mpd.service: Deactivated successfully.
Apr 04 03:03:10 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Apr 04 03:03:10 volumio systemd[1]: mpd.service: Consumed 4.609s CPU time.
Apr 04 03:03:10 volumio systemd[1]: mpd.socket: Deactivated successfully.
Apr 04 03:03:10 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Apr 04 03:03:10 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Apr 04 03:03:10 volumio volumio[26995]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:10 volumio volumio[26995]: Unhandled rejection Error: No sockets available, cannot start.
Apr 04 03:03:10 volumio volumio[26995]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Apr 04 03:03:10 volumio volumio[26995]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Apr 04 03:03:10 volumio volumio[26995]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Apr 04 03:03:10 volumio volumio[26995]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Apr 04 03:03:10 volumio volumio[26995]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Apr 04 03:03:10 volumio volumio[26995]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Apr 04 03:03:10 volumio volumio[26995]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Apr 04 03:03:10 volumio volumio[26995]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Apr 04 03:03:10 volumio volumio[26995]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14)
Apr 04 03:03:10 volumio volumio[26995]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Apr 04 03:03:10 volumio volumio[26995]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Apr 04 03:03:10 volumio volumio[26995]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Apr 04 03:03:10 volumio volumio[26995]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Apr 04 03:03:10 volumio volumio[26995]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Apr 04 03:03:10 volumio volumio[26995]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Apr 04 03:03:10 volumio volumio[26995]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 04 03:03:10 volumio volumio[26995]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 04 03:03:10 volumio volumio[26995]: info: Reading ALSA contributions from plugins.
Apr 04 03:03:10 volumio volumio[26995]: info: MPD Permissions set
Apr 04 03:03:10 volumio volumio[26995]: info: MPD Permissions set
Apr 04 03:03:10 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Apr 04 03:03:10 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Apr 04 03:03:10 volumio volumio[26995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Apr 04 03:03:10 volumio volumio[26995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Apr 04 03:03:10 volumio volumio[26995]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:10 volumio volumio[26995]: info: CoreStateMachine::pushState
Apr 04 03:03:10 volumio volumio[26995]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:10 volumio volumio[26995]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:10 volumio volumio[26995]: info: [squeezelite_mc] Server discovery started
Apr 04 03:03:10 volumio volumio[26995]: info: [squeezelite_mc] Player finder started
Apr 04 03:03:10 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:10 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:10 volumio volumio[26995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:10 volumio volumio[26995]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"","card":"4","mixerType":"Hardware","mixer":"Digital"}
Apr 04 03:03:10 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:10.585+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 04 03:03:10 volumio volumio[26995]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Apr 04 03:03:10 volumio volumio[26995]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 03:03:10 volumio volumio[26995]: Error: send ENETUNREACH 255.255.255.255:3483
Apr 04 03:03:10 volumio volumio[26995]: at doSend (node:dgram:717:16)
Apr 04 03:03:10 volumio volumio[26995]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18)
Apr 04 03:03:10 volumio volumio[26995]: at afterDns (node:dgram:663:5)
Apr 04 03:03:10 volumio volumio[26995]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) {
Apr 04 03:03:10 volumio volumio[26995]: errno: -101,
Apr 04 03:03:10 volumio volumio[26995]: code: 'ENETUNREACH',
Apr 04 03:03:10 volumio volumio[26995]: syscall: 'send',
Apr 04 03:03:10 volumio volumio[26995]: address: '255.255.255.255',
Apr 04 03:03:10 volumio volumio[26995]: port: 3483
Apr 04 03:03:10 volumio volumio[26995]: }
Apr 04 03:03:10 volumio volumio[26995]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 03:03:10 volumio sudo[27206]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 04 03:03:10 volumio sudo[27206]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 04 03:03:10 volumio sudo[27216]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Apr 04 03:03:10 volumio sudo[27216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:10 volumio sudo[27206]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:10 volumio sudo[27216]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:11 volumio sudo[27234]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-04 03:02'
Apr 04 03:03:11 volumio sudo[27234]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:11 volumio sudo[27234]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:12 volumio volumio-remote-updater[736]: [2026-04-04 03:03:12] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 04 03:03:12 volumio volumio-remote-updater[736]: [2026-04-04 03:03:12] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 04 03:03:12 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:12.186+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF"
Apr 04 03:03:12 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 03:03:12 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:12.194+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 04 03:03:12 volumio sudo[27157]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:12 volumio sudo[27169]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:12 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 04 03:03:12 volumio systemd[1]: volumio.service: Consumed 30.663s CPU time.
Apr 04 03:03:12 volumio systemd[1]: Started dynamicswap.service - dynamicswap service.
Apr 04 03:03:12 volumio wpa_supplicant[1135]: wlan0: Trying to associate with 80:2a:a8:11:32:52 (SSID='DSDK' freq=2427 MHz)
Apr 04 03:03:12 volumio systemd[1]: dynamicswap.service: Deactivated successfully.
Apr 04 03:03:12 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 126.
Apr 04 03:03:12 volumio systemd[1]: Started dynamicswap.service - dynamicswap service.
Apr 04 03:03:12 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module.
Apr 04 03:03:12 volumio systemd[1]: volumio.service: Consumed 30.663s CPU time.
Apr 04 03:03:12 volumio systemd[1]: Started volumio.service - Volumio Backend Module.
Apr 04 03:03:12 volumio systemd[1]: dynamicswap.service: Deactivated successfully.
Apr 04 03:03:12 volumio wpa_supplicant[1135]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16
Apr 04 03:03:12 volumio wpa_supplicant[1135]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="DSDK" auth_failures=3 duration=46 reason=CONN_FAILED
Apr 04 03:03:13 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:13.200+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 04 03:03:14 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:14.203+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 04 03:03:14 volumio volumio[27253]: info: -------------------------------------------
Apr 04 03:03:14 volumio volumio[27253]: info: ----- Volumio3 ----
Apr 04 03:03:14 volumio volumio[27253]: info: -------------------------------------------
Apr 04 03:03:14 volumio volumio[27253]: info: ----- System startup ----
Apr 04 03:03:14 volumio volumio[27253]: info: -------------------------------------------
Apr 04 03:03:15 volumio volumio[27253]: info: MYVOLUMIO Environment detected
Apr 04 03:03:15 volumio volumio[27253]: info: Plugin folders cleanup
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning into folder /volumio/app/plugins/
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category audio_interface
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category miscellanea
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category music_service
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category plugins.json
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category system_controller
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category user_interface
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning into folder /data/plugins/
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category audio_interface
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category music_service
Apr 04 03:03:15 volumio volumio[27253]: info: Scanning category system_controller
Apr 04 03:03:15 volumio volumio[27253]: info: Plugin folders cleanup completed
Apr 04 03:03:15 volumio volumio[27253]: info: -------------------------------------------
Apr 04 03:03:15 volumio volumio[27253]: info: ----- Core plugins startup ----
Apr 04 03:03:15 volumio volumio[27253]: info: -------------------------------------------
Apr 04 03:03:15 volumio volumio[27253]: info: Loading plugins from folder /volumio/app/plugins/
Apr 04 03:03:15 volumio volumio[27253]: info: Adding plugin upnp to MyMusic Plugins
Apr 04 03:03:15 volumio volumio[27253]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 04 03:03:15 volumio volumio[27253]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 04 03:03:15 volumio volumio[27253]: info: Loading plugins from folder /data/plugins/
Apr 04 03:03:15 volumio volumio[27253]: info: Adding plugin rtlsdr_radio to MyMusic Plugins
Apr 04 03:03:15 volumio volumio[27253]: info: Loading plugin "system"...
Apr 04 03:03:15 volumio volumio[27253]: info: Loading plugin "appearance"...
Apr 04 03:03:16 volumio mpd[27229]: 2026-04-04T03:03:16 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 04 03:03:16 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "network"...
Apr 04 03:03:17 volumio volumio[27253]: info: Refreshing Cached IP Addresses
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "services"...
Apr 04 03:03:17 volumio sudo[27283]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 03:03:17 volumio sudo[27283]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "volumio5onboarding"...
Apr 04 03:03:17 volumio sudo[27285]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 03:03:17 volumio sudo[27283]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:17 volumio sudo[27285]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "alsa_controller"...
Apr 04 03:03:17 volumio sudo[27285]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:17 volumio sudo[27292]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 04 03:03:17 volumio sudo[27292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:17 volumio volumio-remote-updater[736]: [2026-04-04 03:03:17] [connect] Successful connection
Apr 04 03:03:17 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "wizard"...
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "networkfs"...
Apr 04 03:03:17 volumio volumio[27253]: info: Cannot mount NAS DJA at system boot, trial number 1 ,retrying in 5 seconds
Apr 04 03:03:17 volumio volumio[27253]: info: Starting Udev Watcher for removable devices
Apr 04 03:03:17 volumio volumio[27253]: info: Ignoring mount for partition: boot
Apr 04 03:03:17 volumio volumio[27253]: info: Ignoring mount for partition: volumio
Apr 04 03:03:17 volumio volumio[27253]: info: Ignoring mount for partition: volumio_data
Apr 04 03:03:17 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "volumio_command_line_client"...
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "upnp"...
Apr 04 03:03:17 volumio volumio[27253]: info: [1775264597329] Starting Upmpd Daemon
Apr 04 03:03:17 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "my_music"...
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "mpd"...
Apr 04 03:03:17 volumio volumio[27253]: info: Loading plugin "upnp_browser"...
Apr 04 03:03:17 volumio sudo[27292]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:19 volumio volumio[27253]: info: Starting UPNP Browser
Apr 04 03:03:19 volumio volumio[27253]: info: Loading plugin "alarm-clock"...
Apr 04 03:03:19 volumio volumio[27253]: info: Loading plugin "airplay_emulation"...
Apr 04 03:03:19 volumio volumio[27253]: info: Starting Shairport Sync
Apr 04 03:03:19 volumio volumio[27253]: info: Loading plugin "last_100"...
Apr 04 03:03:19 volumio volumio[27253]: info: Loading plugin "webradio"...
Apr 04 03:03:19 volumio volumio[27253]: info: Loading plugin "i2s_dacs"...
Apr 04 03:03:19 volumio volumio[27253]: info: Loading plugin "volumiodiscovery"...
Apr 04 03:03:19 volumio volumio[27253]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:19 volumio volumio[27253]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:19 volumio volumio[27253]: *** WARNING *** For more information see
Apr 04 03:03:19 volumio volumio[27253]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:19 volumio volumio[27253]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:19 volumio volumio[27253]: *** WARNING *** For more information see
Apr 04 03:03:19 volumio node[27253]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:19 volumio node[27253]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:19 volumio node[27253]: *** WARNING *** For more information see
Apr 04 03:03:19 volumio node[27253]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:19 volumio node[27253]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:19 volumio node[27253]: *** WARNING *** For more information see
Apr 04 03:03:19 volumio volumio[27253]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 04 03:03:19 volumio volumio[27253]: info: Discovery: Started advertising with name: Volumio
Apr 04 03:03:19 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:19 volumio volumio[27253]: info: Loading plugin "bandcamp"...
Apr 04 03:03:20 volumio volumio[27253]: info: Loading plugin "calmradio"...
Apr 04 03:03:21 volumio volumio[27253]: info: Loading plugin "soundcloud"...
Apr 04 03:03:22 volumio volumio[27253]: info: Loading plugin "squeezelite_mc"...
Apr 04 03:03:22 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:22.801+02:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded"
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "SleepWakePlugin"...
Apr 04 03:03:23 volumio volumio[27253]: info: Applying required configuration parameters for plugin SleepWakePlugin
Apr 04 03:03:23 volumio volumio[27253]: info: SleepWakePlugin - onVolumioStart
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "outputs"...
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "albumart"...
Apr 04 03:03:23 volumio volumio[27253]: info: Plugin example_plugin is not enabled
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "inputs"...
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "updater_comm"...
Apr 04 03:03:23 volumio volumio[27253]: info: Plugin mpdemulation is not enabled
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "rest_api"...
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "websocket"...
Apr 04 03:03:23 volumio volumio[27253]: info: Starting Socket.io Server version 1.7.4
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "fusiondsp"...
Apr 04 03:03:23 volumio volumio[27253]: info: Applying required configuration parameters for plugin fusiondsp
Apr 04 03:03:23 volumio volumio[27318]: Forking 3 albumart workers
Apr 04 03:03:23 volumio volumio[27253]: info: Loading plugin "mpdoutput"...
Apr 04 03:03:24 volumio volumio[27253]: info: Loading plugin "80s80s"...
Apr 04 03:03:24 volumio volumio[27253]: info: Applying required configuration parameters for plugin 80s80s
Apr 04 03:03:24 volumio volumio[27253]: info: [1775264604501] [80s80s] API delay: 30
Apr 04 03:03:24 volumio volumio[27253]: info: Loading plugin "RoonBridge"...
Apr 04 03:03:24 volumio volumio[27253]: info: Applying required configuration parameters for plugin RoonBridge
Apr 04 03:03:24 volumio volumio[27253]: info: Loading plugin "motherearthradio"...
Apr 04 03:03:25 volumio volumio[27253]: info: Applying required configuration parameters for plugin motherearthradio
Apr 04 03:03:25 volumio volumio[27253]: info: [1775264605202] [MotherEarth] API delay: 5
Apr 04 03:03:25 volumio volumio[27253]: info: Loading plugin "radio_paradise"...
Apr 04 03:03:25 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:25.208+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:36932->127.0.0.1:3000: i/o timeout"
Apr 04 03:03:25 volumio volumio[27330]: Starting albumart workers
Apr 04 03:03:25 volumio volumio[27329]: Starting albumart workers
Apr 04 03:03:25 volumio volumio[27328]: Starting albumart workers
Apr 04 03:03:25 volumio volumio[27253]: info: Applying required configuration parameters for plugin radio_paradise
Apr 04 03:03:25 volumio volumio[27253]: info: [1775264605565] [RadioParadise] API delay: 5
Apr 04 03:03:25 volumio volumio[27253]: info: Loading plugin "rtlsdr_radio"...
Apr 04 03:03:26 volumio volumio[27253]: info: Loading i18n strings for locale it
Apr 04 03:03:26 volumio volumio[27253]: Updating browse sources language
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::initPlayerControls
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:26 volumio volumio[27253]: Express server listening on port 3000
Apr 04 03:03:26 volumio volumio[27253]: [Metrics] WebUI: 12s 731.05ms
Apr 04 03:03:26 volumio volumio[27253]: info: CoreStateMachine::resetVolumioState
Apr 04 03:03:26 volumio volumio[27253]: info: CoreStateMachine::getcurrentVolume
Apr 04 03:03:26 volumio volumio[27253]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:26 volumio volumio[27253]: info: Cannot mount NAS DJA at system boot, trial number 2 ,retrying in 5 seconds
Apr 04 03:03:27 volumio volumio[27253]: info: Volumio Network Manager: Network status updated: 0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:27 volumio volumio[27253]: info: Reloading queue from file
Apr 04 03:03:27 volumio volumio[27253]: 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
Apr 04 03:03:27 volumio volumio[27253]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:27 volumio volumio[27253]: info: CoreStateMachine::pushState
Apr 04 03:03:27 volumio volumio[27253]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:27 volumio volumio[27253]: info: CoreStateMachine::updateTrackBlock
Apr 04 03:03:27 volumio volumio[27253]: info: CorePlayQueue::getTrackBlock
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:27 volumio volumio[27253]: info: CoreStateMachine::setRepeat false single undefined
Apr 04 03:03:27 volumio volumio[27253]: info: CoreStateMachine::pushState
Apr 04 03:03:27 volumio volumio[27253]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:27 volumio volumio[27253]: info: CoreStateMachine::setRandom undefined
Apr 04 03:03:27 volumio volumio[27253]: info: CoreStateMachine::pushState
Apr 04 03:03:27 volumio volumio[27253]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:27 volumio volumio[27253]: info: Setting Device type: Raspberry PI
Apr 04 03:03:27 volumio volumio[27253]: info: Completed loading Core Plugins
Apr 04 03:03:27 volumio volumio[27253]: info: Preparing to generate the ALSA configuration file
Apr 04 03:03:27 volumio volumio[27253]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 04 03:03:27 volumio volumio[27253]: info: Reading ALSA contributions from plugins.
Apr 04 03:03:27 volumio volumio[27253]: 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
Apr 04 03:03:27 volumio sudo[27406]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 03:03:27 volumio sudo[27404]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 03:03:27 volumio volumio[27253]: 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
Apr 04 03:03:27 volumio volumio[27253]: info: Received Get System Info
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 04 03:03:27 volumio sudo[27406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 04 03:03:27 volumio volumio[27253]: info: Discovery: Getting this device information
Apr 04 03:03:27 volumio sudo[27404]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioGetState
Apr 04 03:03:27 volumio volumio[27253]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 04 03:03:27 volumio sudo[27404]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:27 volumio sudo[27406]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:27 volumio volumio[27253]: info: Received Get System Info
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 04 03:03:27 volumio volumio[27253]: info: Discovery: Getting this device information
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioGetState
Apr 04 03:03:27 volumio volumio[27253]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 04 03:03:27 volumio volumio[27253]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:27 volumio volumio[27253]: info: CoreStateMachine::pushState
Apr 04 03:03:27 volumio volumio[27253]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 04 03:03:27 volumio volumio[27253]: info: Discovery: adding c69f8783-26e2-48e2-a8ae-e3cb917f598f
Apr 04 03:03:27 volumio volumio[27253]: info: Discovery: Found device Volumio
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioGetState
Apr 04 03:03:27 volumio volumio[27253]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:27 volumio volumio[27253]: info: Asound.conf file unchanged, so no further update is needed
Apr 04 03:03:27 volumio volumio[27253]: info: Output device has changed, restarting MPD
Apr 04 03:03:27 volumio sudo[27412]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 04 03:03:27 volumio sudo[27412]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:27 volumio volumio[27253]: info: Output device has changed, restarting Shairport Sync
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:27 volumio sudo[27414]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 03:03:27 volumio sudo[27414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:27 volumio sudo[27414]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:27 volumio sudo[27417]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 03:03:27 volumio sudo[27417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:27 volumio volumio[27253]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:27 volumio volumio[27253]: info: ___________ START PLUGINS ___________
Apr 04 03:03:27 volumio volumio[27253]: info: ControllerMpd::onStart: Initializing MPD
Apr 04 03:03:27 volumio volumio[27253]: info: Creating MPD Configuration file
Apr 04 03:03:27 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Apr 04 03:03:27 volumio sudo[27412]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:27 volumio volumio[27253]: info: [1775264607642] CoreMusicLibrary::Adding element Server multimediali
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:27 volumio sudo[27425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Apr 04 03:03:27 volumio sudo[27425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:27 volumio volumio[27253]: info: UPNP Browser: Client initialized successfully
Apr 04 03:03:27 volumio sudo[27429]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 03:03:27 volumio sudo[27429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:27 volumio sudo[27427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:27 volumio sudo[27427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:27 volumio sudo[27427]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:27 volumio volumio[27253]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:27 volumio volumio[27253]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:27 volumio volumio[27253]: info: [1775264607769] CoreMusicLibrary::Adding element Last_100
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:27 volumio sudo[27425]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:27 volumio volumio[27253]: info: [1775264607773] CoreMusicLibrary::Adding element Webradio
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:27 volumio volumio[27253]: info: Initializing BBC Radios
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:27 volumio volumio[27253]: info: [1775264607863] CoreMusicLibrary::Adding element Bandcamp Discover
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:27 volumio volumio[27253]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:27 volumio volumio[27253]: info: Adding Calm Radio to Browse Sources
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:27 volumio volumio[27253]: info: [1775264607879] CoreMusicLibrary::Adding element Calm Radio
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:27 volumio volumio[27253]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:27 volumio volumio[27253]: Cannot find translation for source Calm Radio
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:27 volumio volumio[27253]: info: [1775264607891] CoreMusicLibrary::Adding element SoundCloud
Apr 04 03:03:27 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:27 volumio volumio[27253]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:27 volumio volumio[27253]: Cannot find translation for source Calm Radio
Apr 04 03:03:27 volumio volumio[27253]: Cannot find translation for source SoundCloud
Apr 04 03:03:27 volumio systemd[1]: mpd.service: Deactivated successfully.
Apr 04 03:03:27 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Apr 04 03:03:27 volumio systemd[1]: mpd.service: Consumed 5.254s CPU time.
Apr 04 03:03:27 volumio systemd[1]: mpd.socket: Deactivated successfully.
Apr 04 03:03:27 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Apr 04 03:03:27 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Apr 04 03:03:27 volumio volumio[27253]: info: [squeezelite_mc] Starting proxy server...
Apr 04 03:03:27 volumio volumio[27253]: info: SleepWakePlugin - onStart
Apr 04 03:03:27 volumio volumio[27253]: info: SleepWakePlugin - Sleep scheduled in 78992073 milliseconds
Apr 04 03:03:27 volumio volumio[27253]: info: SleepWakePlugin - Wake scheduled in 14192069 milliseconds
Apr 04 03:03:27 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Apr 04 03:03:27 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Apr 04 03:03:27 volumio volumio[27253]: info: FusionDsp - CamillaDSP binary found.
Apr 04 03:03:27 volumio volumio[27253]: info: Loading i18n strings for locale it
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:28 volumio volumio[27253]: info: FusionDsp - mixtype--------------------- Hardware
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:28 volumio volumio[27253]: info: [1775264608011] CoreMusicLibrary::Adding element 80s80s Radio
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Calm Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source SoundCloud
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:28 volumio volumio[27253]: info: [1775264608030] CoreMusicLibrary::Adding element Mother Earth Radio
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Calm Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source SoundCloud
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:28 volumio volumio[27253]: info: [1775264608040] CoreMusicLibrary::Adding element Radio Paradise
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Calm Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source SoundCloud
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Radio Paradise
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Starting plugin
Apr 04 03:03:28 volumio sudo[27457]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Loaded i18n strings for language: it
Apr 04 03:03:28 volumio sudo[27457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:28 volumio volumio[27253]: info: Volumio Calling Home
Apr 04 03:03:28 volumio sudo[27457]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:28 volumio volumio[27253]: info: [squeezelite_mc] Proxy server started on port 38481
Apr 04 03:03:28 volumio volumio[27253]: info: Preparing to generate the ALSA configuration file
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] snd-aloop already loaded
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Database version: 2
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Loaded v2 database successfully
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Database loaded at: 2026-04-04T01:03:28.218Z
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Loading blocklist from: /data/plugins/music_service/rtlsdr_radio/blocklist.json
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Got 21 phrases from file
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Updated metadata blocklist
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Metadata module now has 21 phrases
Apr 04 03:03:28 volumio sudo[27455]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 04 03:03:28 volumio sudo[27455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 04 03:03:28 volumio sudo[27455]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Management server started on port 3456
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:28 volumio volumio[27253]: info: [1775264608347] CoreMusicLibrary::Adding element FM/DAB Radio
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Calm Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source SoundCloud
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source Radio Paradise
Apr 04 03:03:28 volumio volumio[27253]: Cannot find translation for source FM/DAB Radio
Apr 04 03:03:28 volumio volumio[27253]: info: [RTL-SDR Radio] Plugin started successfully
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:28 volumio volumio[27253]: Unhandled rejection Error: No sockets available, cannot start.
Apr 04 03:03:28 volumio volumio[27253]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Apr 04 03:03:28 volumio volumio[27253]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Apr 04 03:03:28 volumio volumio[27253]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Apr 04 03:03:28 volumio volumio[27253]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Apr 04 03:03:28 volumio volumio[27253]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Apr 04 03:03:28 volumio volumio[27253]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Apr 04 03:03:28 volumio volumio[27253]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Apr 04 03:03:28 volumio volumio[27253]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Apr 04 03:03:28 volumio volumio[27253]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14)
Apr 04 03:03:28 volumio volumio[27253]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Apr 04 03:03:28 volumio volumio[27253]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Apr 04 03:03:28 volumio volumio[27253]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Apr 04 03:03:28 volumio volumio[27253]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Apr 04 03:03:28 volumio volumio[27253]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Apr 04 03:03:28 volumio volumio[27253]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Apr 04 03:03:28 volumio volumio[27253]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 04 03:03:28 volumio volumio[27253]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 04 03:03:28 volumio volumio[27253]: info: Reading ALSA contributions from plugins.
Apr 04 03:03:28 volumio volumio[27253]: info: MPD Permissions set
Apr 04 03:03:28 volumio volumio[27253]: info: MPD Permissions set
Apr 04 03:03:28 volumio volumio[27253]: info: Upmpdcli Daemon Started
Apr 04 03:03:28 volumio volumio[27253]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Apr 04 03:03:28 volumio volumio[27253]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:28 volumio volumio[27253]: info: CoreStateMachine::pushState
Apr 04 03:03:28 volumio volumio[27253]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:28 volumio volumio[27253]: info: [squeezelite_mc] Server discovery started
Apr 04 03:03:28 volumio volumio[27253]: info: [squeezelite_mc] Player finder started
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:28 volumio volumio[27253]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:28 volumio volumio[27253]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"","card":"4","mixerType":"Hardware","mixer":"Digital"}
Apr 04 03:03:28 volumio volumio[27253]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Apr 04 03:03:28 volumio volumio[27253]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 03:03:28 volumio volumio[27253]: Error: send ENETUNREACH 255.255.255.255:3483
Apr 04 03:03:28 volumio volumio[27253]: at doSend (node:dgram:717:16)
Apr 04 03:03:28 volumio volumio[27253]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18)
Apr 04 03:03:28 volumio volumio[27253]: at afterDns (node:dgram:663:5)
Apr 04 03:03:28 volumio volumio[27253]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) {
Apr 04 03:03:28 volumio volumio[27253]: errno: -101,
Apr 04 03:03:28 volumio volumio[27253]: code: 'ENETUNREACH',
Apr 04 03:03:28 volumio volumio[27253]: syscall: 'send',
Apr 04 03:03:28 volumio volumio[27253]: address: '255.255.255.255',
Apr 04 03:03:28 volumio volumio[27253]: port: 3483
Apr 04 03:03:28 volumio volumio[27253]: }
Apr 04 03:03:28 volumio volumio[27253]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 03:03:28 volumio sudo[27472]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Apr 04 03:03:28 volumio sudo[27472]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:29 volumio sudo[27472]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:29 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:29.283+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 04 03:03:29 volumio volumio-remote-updater[736]: [2026-04-04 03:03:29] [connect] Successful connection
Apr 04 03:03:29 volumio sudo[27488]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-04 03:02'
Apr 04 03:03:29 volumio sudo[27488]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:30 volumio sudo[27488]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:30 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:30.210+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF"
Apr 04 03:03:30 volumio volumio-remote-updater[736]: [2026-04-04 03:03:30] [error] handle_read_http_response error: asio.system:104 (Connection reset by peer)
Apr 04 03:03:30 volumio volumio-remote-updater[736]: [2026-04-04 03:03:30] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected)
Apr 04 03:03:30 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:30.213+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 04 03:03:30 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 03:03:30 volumio sudo[27417]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:30 volumio sudo[27429]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:30 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 04 03:03:30 volumio systemd[1]: volumio.service: Consumed 28.849s CPU time.
Apr 04 03:03:30 volumio systemd[1]: Started dynamicswap.service - dynamicswap service.
Apr 04 03:03:30 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 127.
Apr 04 03:03:30 volumio systemd[1]: dynamicswap.service: Deactivated successfully.
Apr 04 03:03:30 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module.
Apr 04 03:03:30 volumio systemd[1]: volumio.service: Consumed 28.849s CPU time.
Apr 04 03:03:30 volumio systemd[1]: Started volumio.service - Volumio Backend Module.
Apr 04 03:03:31 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:31.216+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 04 03:03:31 volumio mpd[27467]: 2026-04-04T03:03:31 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 04 03:03:31 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Apr 04 03:03:32 volumio volumio[27502]: info: -------------------------------------------
Apr 04 03:03:32 volumio volumio[27502]: info: ----- Volumio3 ----
Apr 04 03:03:32 volumio volumio[27502]: info: -------------------------------------------
Apr 04 03:03:32 volumio volumio[27502]: info: ----- System startup ----
Apr 04 03:03:32 volumio volumio[27502]: info: -------------------------------------------
Apr 04 03:03:33 volumio volumio[27502]: info: MYVOLUMIO Environment detected
Apr 04 03:03:33 volumio volumio[27502]: info: Plugin folders cleanup
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning into folder /volumio/app/plugins/
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category audio_interface
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category miscellanea
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category music_service
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category plugins.json
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category system_controller
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category user_interface
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning into folder /data/plugins/
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category audio_interface
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category music_service
Apr 04 03:03:33 volumio volumio[27502]: info: Scanning category system_controller
Apr 04 03:03:33 volumio volumio[27502]: info: Plugin folders cleanup completed
Apr 04 03:03:33 volumio volumio[27502]: info: -------------------------------------------
Apr 04 03:03:33 volumio volumio[27502]: info: ----- Core plugins startup ----
Apr 04 03:03:33 volumio volumio[27502]: info: -------------------------------------------
Apr 04 03:03:33 volumio volumio[27502]: info: Loading plugins from folder /volumio/app/plugins/
Apr 04 03:03:33 volumio volumio[27502]: info: Adding plugin upnp to MyMusic Plugins
Apr 04 03:03:33 volumio volumio[27502]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 04 03:03:33 volumio volumio[27502]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 04 03:03:33 volumio volumio[27502]: info: Loading plugins from folder /data/plugins/
Apr 04 03:03:33 volumio volumio[27502]: info: Adding plugin rtlsdr_radio to MyMusic Plugins
Apr 04 03:03:33 volumio volumio[27502]: info: Loading plugin "system"...
Apr 04 03:03:33 volumio volumio[27502]: info: Loading plugin "appearance"...
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "network"...
Apr 04 03:03:35 volumio volumio[27502]: info: Refreshing Cached IP Addresses
Apr 04 03:03:35 volumio sudo[27528]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 03:03:35 volumio sudo[27528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:35 volumio sudo[27528]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:35 volumio sudo[27530]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 03:03:35 volumio sudo[27530]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "services"...
Apr 04 03:03:35 volumio sudo[27530]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "volumio5onboarding"...
Apr 04 03:03:35 volumio sudo[27539]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 04 03:03:35 volumio sudo[27539]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "alsa_controller"...
Apr 04 03:03:35 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "wizard"...
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "networkfs"...
Apr 04 03:03:35 volumio volumio[27502]: info: Cannot mount NAS DJA at system boot, trial number 1 ,retrying in 5 seconds
Apr 04 03:03:35 volumio volumio[27502]: info: Starting Udev Watcher for removable devices
Apr 04 03:03:35 volumio volumio[27502]: info: Ignoring mount for partition: boot
Apr 04 03:03:35 volumio volumio[27502]: info: Ignoring mount for partition: volumio
Apr 04 03:03:35 volumio volumio[27502]: info: Ignoring mount for partition: volumio_data
Apr 04 03:03:35 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "volumio_command_line_client"...
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "upnp"...
Apr 04 03:03:35 volumio volumio[27502]: info: [1775264615530] Starting Upmpd Daemon
Apr 04 03:03:35 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "my_music"...
Apr 04 03:03:35 volumio volumio[27502]: info: Loading plugin "mpd"...
Apr 04 03:03:36 volumio volumio[27502]: info: Loading plugin "upnp_browser"...
Apr 04 03:03:36 volumio sudo[27539]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:37 volumio volumio[27502]: info: Starting UPNP Browser
Apr 04 03:03:37 volumio volumio[27502]: info: Loading plugin "alarm-clock"...
Apr 04 03:03:37 volumio volumio[27502]: info: Loading plugin "airplay_emulation"...
Apr 04 03:03:37 volumio volumio[27502]: info: Starting Shairport Sync
Apr 04 03:03:37 volumio volumio[27502]: info: Loading plugin "last_100"...
Apr 04 03:03:37 volumio volumio[27502]: info: Loading plugin "webradio"...
Apr 04 03:03:38 volumio volumio[27502]: info: Loading plugin "i2s_dacs"...
Apr 04 03:03:38 volumio volumio[27502]: info: Loading plugin "volumiodiscovery"...
Apr 04 03:03:38 volumio volumio[27502]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:38 volumio volumio[27502]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:38 volumio volumio[27502]: *** WARNING *** For more information see
Apr 04 03:03:38 volumio volumio[27502]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:38 volumio volumio[27502]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:38 volumio volumio[27502]: *** WARNING *** For more information see
Apr 04 03:03:38 volumio node[27502]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:38 volumio node[27502]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:38 volumio node[27502]: *** WARNING *** For more information see
Apr 04 03:03:38 volumio node[27502]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:38 volumio node[27502]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:38 volumio node[27502]: *** WARNING *** For more information see
Apr 04 03:03:38 volumio volumio[27502]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 04 03:03:38 volumio volumio[27502]: info: Discovery: Started advertising with name: Volumio
Apr 04 03:03:38 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:38 volumio volumio[27502]: info: Loading plugin "bandcamp"...
Apr 04 03:03:39 volumio volumio[27502]: info: Loading plugin "calmradio"...
Apr 04 03:03:40 volumio volumio-remote-updater[736]: [2026-04-04 03:03:40] [connect] Successful connection
Apr 04 03:03:40 volumio volumio[27502]: info: Loading plugin "soundcloud"...
Apr 04 03:03:41 volumio volumio[27502]: info: Loading plugin "squeezelite_mc"...
Apr 04 03:03:41 volumio volumio[27502]: info: Loading plugin "SleepWakePlugin"...
Apr 04 03:03:41 volumio volumio[27502]: info: Applying required configuration parameters for plugin SleepWakePlugin
Apr 04 03:03:41 volumio volumio[27502]: info: SleepWakePlugin - onVolumioStart
Apr 04 03:03:41 volumio volumio[27502]: info: Loading plugin "outputs"...
Apr 04 03:03:41 volumio volumio[27502]: info: Loading plugin "albumart"...
Apr 04 03:03:41 volumio volumio[27502]: info: Plugin example_plugin is not enabled
Apr 04 03:03:41 volumio volumio[27502]: info: Loading plugin "inputs"...
Apr 04 03:03:41 volumio volumio[27502]: info: Loading plugin "updater_comm"...
Apr 04 03:03:42 volumio volumio[27502]: info: Plugin mpdemulation is not enabled
Apr 04 03:03:42 volumio volumio[27502]: info: Loading plugin "rest_api"...
Apr 04 03:03:42 volumio volumio[27502]: info: Loading plugin "websocket"...
Apr 04 03:03:42 volumio volumio[27502]: info: Starting Socket.io Server version 1.7.4
Apr 04 03:03:42 volumio volumio[27502]: info: Loading plugin "fusiondsp"...
Apr 04 03:03:42 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:42.219+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:39514->127.0.0.1:3000: i/o timeout"
Apr 04 03:03:42 volumio volumio[27502]: info: Applying required configuration parameters for plugin fusiondsp
Apr 04 03:03:42 volumio volumio[27502]: info: Loading plugin "mpdoutput"...
Apr 04 03:03:42 volumio volumio[27563]: Forking 3 albumart workers
Apr 04 03:03:42 volumio volumio[27502]: info: Loading plugin "80s80s"...
Apr 04 03:03:43 volumio volumio[27502]: info: Applying required configuration parameters for plugin 80s80s
Apr 04 03:03:43 volumio volumio[27502]: info: [1775264623184] [80s80s] API delay: 30
Apr 04 03:03:43 volumio volumio[27502]: info: Loading plugin "RoonBridge"...
Apr 04 03:03:43 volumio volumio[27502]: info: Applying required configuration parameters for plugin RoonBridge
Apr 04 03:03:43 volumio volumio[27502]: info: Loading plugin "motherearthradio"...
Apr 04 03:03:43 volumio volumio[27502]: info: Applying required configuration parameters for plugin motherearthradio
Apr 04 03:03:43 volumio volumio[27502]: info: [1775264623782] [MotherEarth] API delay: 5
Apr 04 03:03:43 volumio volumio[27502]: info: Loading plugin "radio_paradise"...
Apr 04 03:03:44 volumio volumio[27573]: Starting albumart workers
Apr 04 03:03:44 volumio volumio[27502]: info: Applying required configuration parameters for plugin radio_paradise
Apr 04 03:03:44 volumio volumio[27502]: info: [1775264624096] [RadioParadise] API delay: 5
Apr 04 03:03:44 volumio volumio[27502]: info: Loading plugin "rtlsdr_radio"...
Apr 04 03:03:44 volumio volumio[27574]: Starting albumart workers
Apr 04 03:03:44 volumio volumio[27575]: Starting albumart workers
Apr 04 03:03:44 volumio volumio[27502]: info: Loading i18n strings for locale it
Apr 04 03:03:44 volumio volumio[27502]: Updating browse sources language
Apr 04 03:03:44 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::initPlayerControls
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: Express server listening on port 3000
Apr 04 03:03:45 volumio volumio[27502]: [Metrics] WebUI: 13s 68.82ms
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::resetVolumioState
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::getcurrentVolume
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:45 volumio volumio[27502]: info: Cannot mount NAS DJA at system boot, trial number 2 ,retrying in 5 seconds
Apr 04 03:03:45 volumio volumio[27502]: info: Volumio Network Manager: Network status updated: 0
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: Reloading queue from file
Apr 04 03:03:45 volumio volumio[27502]: 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
Apr 04 03:03:45 volumio volumio[27502]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::pushState
Apr 04 03:03:45 volumio volumio[27502]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::updateTrackBlock
Apr 04 03:03:45 volumio volumio[27502]: info: CorePlayQueue::getTrackBlock
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::setRepeat false single undefined
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::pushState
Apr 04 03:03:45 volumio volumio[27502]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::setRandom undefined
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::pushState
Apr 04 03:03:45 volumio volumio[27502]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:45 volumio volumio[27502]: info: Setting Device type: Raspberry PI
Apr 04 03:03:45 volumio volumio[27502]: info: Completed loading Core Plugins
Apr 04 03:03:45 volumio volumio[27502]: info: Preparing to generate the ALSA configuration file
Apr 04 03:03:45 volumio volumio[27502]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 04 03:03:45 volumio volumio[27502]: info: Reading ALSA contributions from plugins.
Apr 04 03:03:45 volumio volumio[27502]: 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
Apr 04 03:03:45 volumio volumio[27502]: 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
Apr 04 03:03:45 volumio volumio[27502]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:45 volumio volumio[27502]: info: CoreStateMachine::pushState
Apr 04 03:03:45 volumio volumio[27502]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:45 volumio volumio[27502]: info: Discovery: adding c69f8783-26e2-48e2-a8ae-e3cb917f598f
Apr 04 03:03:45 volumio volumio[27502]: info: Discovery: Found device Volumio
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioGetState
Apr 04 03:03:45 volumio volumio[27502]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:45 volumio sudo[27649]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 03:03:45 volumio sudo[27649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:45 volumio sudo[27651]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 03:03:45 volumio sudo[27649]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:45 volumio sudo[27651]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:45 volumio volumio[27502]: info: Asound.conf file unchanged, so no further update is needed
Apr 04 03:03:45 volumio volumio[27502]: info: Output device has changed, restarting MPD
Apr 04 03:03:45 volumio sudo[27651]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:45 volumio volumio[27502]: info: Output device has changed, restarting Shairport Sync
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:45 volumio sudo[27657]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 03:03:45 volumio sudo[27657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:45 volumio sudo[27659]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 03:03:45 volumio sudo[27657]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:45 volumio sudo[27659]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:45 volumio volumio[27502]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:45 volumio volumio[27502]: info: ___________ START PLUGINS ___________
Apr 04 03:03:45 volumio volumio[27502]: info: ControllerMpd::onStart: Initializing MPD
Apr 04 03:03:45 volumio volumio[27502]: info: Creating MPD Configuration file
Apr 04 03:03:45 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Apr 04 03:03:45 volumio sudo[27667]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Apr 04 03:03:45 volumio sudo[27667]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:45 volumio volumio[27502]: info: [1775264625726] CoreMusicLibrary::Adding element Server multimediali
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:45 volumio sudo[27670]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 03:03:45 volumio volumio[27502]: info: UPNP Browser: Client initialized successfully
Apr 04 03:03:45 volumio sudo[27670]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:45 volumio sudo[27672]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 03:03:45 volumio sudo[27672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:45 volumio sudo[27667]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:45 volumio sudo[27670]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:45 volumio volumio[27502]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:45 volumio systemd[1]: mpd.service: Deactivated successfully.
Apr 04 03:03:45 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Apr 04 03:03:45 volumio systemd[1]: mpd.service: Consumed 3.809s CPU time.
Apr 04 03:03:45 volumio systemd[1]: mpd.socket: Deactivated successfully.
Apr 04 03:03:45 volumio volumio[27502]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:03:45 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Apr 04 03:03:45 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:45 volumio volumio[27502]: info: [1775264625848] CoreMusicLibrary::Adding element Last_100
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:45 volumio volumio[27502]: info: [1775264625858] CoreMusicLibrary::Adding element Webradio
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:45 volumio volumio[27502]: info: Initializing BBC Radios
Apr 04 03:03:45 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Apr 04 03:03:45 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:45 volumio volumio[27502]: info: [1775264625935] CoreMusicLibrary::Adding element Bandcamp Discover
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:45 volumio volumio[27502]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:45 volumio volumio[27502]: info: Adding Calm Radio to Browse Sources
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:45 volumio volumio[27502]: info: [1775264625945] CoreMusicLibrary::Adding element Calm Radio
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:45 volumio volumio[27502]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:45 volumio volumio[27502]: Cannot find translation for source Calm Radio
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:45 volumio volumio[27502]: info: [1775264625960] CoreMusicLibrary::Adding element SoundCloud
Apr 04 03:03:45 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:45 volumio volumio[27502]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:45 volumio volumio[27502]: Cannot find translation for source Calm Radio
Apr 04 03:03:45 volumio volumio[27502]: Cannot find translation for source SoundCloud
Apr 04 03:03:45 volumio volumio[27502]: info: [squeezelite_mc] Starting proxy server...
Apr 04 03:03:45 volumio volumio[27502]: info: SleepWakePlugin - onStart
Apr 04 03:03:46 volumio volumio[27502]: info: SleepWakePlugin - Sleep scheduled in 78974002 milliseconds
Apr 04 03:03:46 volumio volumio[27502]: info: SleepWakePlugin - Wake scheduled in 14173997 milliseconds
Apr 04 03:03:46 volumio volumio[27502]: info: FusionDsp - CamillaDSP binary found.
Apr 04 03:03:46 volumio volumio[27502]: info: Loading i18n strings for locale it
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:46 volumio volumio[27502]: info: FusionDsp - mixtype--------------------- Hardware
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:46 volumio volumio[27502]: info: [1775264626086] CoreMusicLibrary::Adding element 80s80s Radio
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Calm Radio
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source SoundCloud
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:46 volumio volumio[27502]: info: [1775264626107] CoreMusicLibrary::Adding element Mother Earth Radio
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Calm Radio
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source SoundCloud
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:46 volumio volumio[27502]: info: [1775264626120] CoreMusicLibrary::Adding element Radio Paradise
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Calm Radio
Apr 04 03:03:46 volumio sudo[27699]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Apr 04 03:03:46 volumio sudo[27699]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source SoundCloud
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Radio Paradise
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Starting plugin
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Loaded i18n strings for language: it
Apr 04 03:03:46 volumio volumio[27502]: info: Volumio Calling Home
Apr 04 03:03:46 volumio sudo[27687]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 04 03:03:46 volumio sudo[27687]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 04 03:03:46 volumio sudo[27687]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:46 volumio volumio[27502]: info: [squeezelite_mc] Proxy server started on port 38825
Apr 04 03:03:46 volumio volumio[27502]: info: Preparing to generate the ALSA configuration file
Apr 04 03:03:46 volumio sudo[27699]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] snd-aloop already loaded
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Database version: 2
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Loaded v2 database successfully
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Database loaded at: 2026-04-04T01:03:46.321Z
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Loading blocklist from: /data/plugins/music_service/rtlsdr_radio/blocklist.json
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Got 21 phrases from file
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Updated metadata blocklist
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Metadata module now has 21 phrases
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Management server started on port 3456
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:03:46 volumio volumio[27502]: info: [1775264626440] CoreMusicLibrary::Adding element FM/DAB Radio
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Bandcamp Discover
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Calm Radio
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source SoundCloud
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source 80s80s Radio
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Mother Earth Radio
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source Radio Paradise
Apr 04 03:03:46 volumio volumio[27502]: Cannot find translation for source FM/DAB Radio
Apr 04 03:03:46 volumio volumio[27502]: info: [RTL-SDR Radio] Plugin started successfully
Apr 04 03:03:46 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:46.448+02:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded"
Apr 04 03:03:46 volumio volumio[27502]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:03:46 volumio volumio[27502]: Unhandled rejection Error: No sockets available, cannot start.
Apr 04 03:03:46 volumio volumio[27502]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Apr 04 03:03:46 volumio volumio[27502]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Apr 04 03:03:46 volumio volumio[27502]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Apr 04 03:03:46 volumio volumio[27502]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Apr 04 03:03:46 volumio volumio[27502]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Apr 04 03:03:46 volumio volumio[27502]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Apr 04 03:03:46 volumio volumio[27502]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Apr 04 03:03:46 volumio volumio[27502]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Apr 04 03:03:46 volumio volumio[27502]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14)
Apr 04 03:03:46 volumio volumio[27502]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Apr 04 03:03:46 volumio volumio[27502]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Apr 04 03:03:46 volumio volumio[27502]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Apr 04 03:03:46 volumio volumio[27502]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Apr 04 03:03:46 volumio volumio[27502]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Apr 04 03:03:46 volumio volumio[27502]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Apr 04 03:03:46 volumio volumio[27502]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 04 03:03:46 volumio volumio[27502]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 04 03:03:46 volumio volumio[27502]: info: Reading ALSA contributions from plugins.
Apr 04 03:03:46 volumio sudo[27712]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 04 03:03:46 volumio sudo[27712]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:46 volumio volumio[27502]: info: MPD Permissions set
Apr 04 03:03:46 volumio volumio[27502]: info: MPD Permissions set
Apr 04 03:03:46 volumio sudo[27712]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:47 volumio volumio[27502]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Apr 04 03:03:47 volumio volumio[27502]: info: Upmpdcli Daemon Started
Apr 04 03:03:47 volumio volumio[27502]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:03:47 volumio volumio[27502]: info: CoreStateMachine::pushState
Apr 04 03:03:47 volumio volumio[27502]: info: CorePlayQueue::getTrack 0
Apr 04 03:03:47 volumio volumio[27502]: info: CoreCommandRouter::volumioPushState
Apr 04 03:03:47 volumio volumio[27502]: info: [squeezelite_mc] Server discovery started
Apr 04 03:03:47 volumio volumio[27502]: info: [squeezelite_mc] Player finder started
Apr 04 03:03:47 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:47 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:47 volumio volumio[27502]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:03:47 volumio volumio[27502]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"","card":"4","mixerType":"Hardware","mixer":"Digital"}
Apr 04 03:03:47 volumio volumio[27502]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Apr 04 03:03:47 volumio volumio[27502]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 03:03:47 volumio volumio[27502]: Error: send ENETUNREACH 255.255.255.255:3483
Apr 04 03:03:47 volumio volumio[27502]: at doSend (node:dgram:717:16)
Apr 04 03:03:47 volumio volumio[27502]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18)
Apr 04 03:03:47 volumio volumio[27502]: at afterDns (node:dgram:663:5)
Apr 04 03:03:47 volumio volumio[27502]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) {
Apr 04 03:03:47 volumio volumio[27502]: errno: -101,
Apr 04 03:03:47 volumio volumio[27502]: code: 'ENETUNREACH',
Apr 04 03:03:47 volumio volumio[27502]: syscall: 'send',
Apr 04 03:03:47 volumio volumio[27502]: address: '255.255.255.255',
Apr 04 03:03:47 volumio volumio[27502]: port: 3483
Apr 04 03:03:47 volumio volumio[27502]: }
Apr 04 03:03:47 volumio sudo[27718]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Apr 04 03:03:47 volumio sudo[27718]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:47 volumio volumio[27502]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 03:03:47 volumio sudo[27718]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:47 volumio sudo[27734]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-04 03:02'
Apr 04 03:03:47 volumio sudo[27734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:48 volumio sudo[27734]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:48 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:48.381+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF"
Apr 04 03:03:48 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 03:03:48 volumio sudo[27672]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:48 volumio sudo[27659]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:48 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 04 03:03:48 volumio systemd[1]: volumio.service: Consumed 29.042s CPU time.
Apr 04 03:03:48 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:48.422+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 04 03:03:48 volumio systemd[1]: Started dynamicswap.service - dynamicswap service.
Apr 04 03:03:48 volumio systemd[1]: dynamicswap.service: Deactivated successfully.
Apr 04 03:03:48 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 128.
Apr 04 03:03:48 volumio systemd[1]: Started dynamicswap.service - dynamicswap service.
Apr 04 03:03:48 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module.
Apr 04 03:03:48 volumio systemd[1]: volumio.service: Consumed 29.042s CPU time.
Apr 04 03:03:48 volumio systemd[1]: Started volumio.service - Volumio Backend Module.
Apr 04 03:03:48 volumio systemd[1]: dynamicswap.service: Deactivated successfully.
Apr 04 03:03:49 volumio volumio5-onboarding[2096]: time=2026-04-04T03:03:49.424+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused"
Apr 04 03:03:49 volumio mpd[27704]: 2026-04-04T03:03:49 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 04 03:03:49 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Apr 04 03:03:50 volumio volumio[27751]: info: -------------------------------------------
Apr 04 03:03:50 volumio volumio[27751]: info: ----- Volumio3 ----
Apr 04 03:03:50 volumio volumio[27751]: info: -------------------------------------------
Apr 04 03:03:50 volumio volumio[27751]: info: ----- System startup ----
Apr 04 03:03:50 volumio volumio[27751]: info: -------------------------------------------
Apr 04 03:03:51 volumio volumio[27751]: info: MYVOLUMIO Environment detected
Apr 04 03:03:51 volumio volumio[27751]: info: Plugin folders cleanup
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning into folder /volumio/app/plugins/
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category audio_interface
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category miscellanea
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category music_service
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category plugins.json
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category system_controller
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category user_interface
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning into folder /data/plugins/
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category audio_interface
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category music_service
Apr 04 03:03:51 volumio volumio[27751]: info: Scanning category system_controller
Apr 04 03:03:51 volumio volumio[27751]: info: Plugin folders cleanup completed
Apr 04 03:03:51 volumio volumio[27751]: info: -------------------------------------------
Apr 04 03:03:51 volumio volumio[27751]: info: ----- Core plugins startup ----
Apr 04 03:03:51 volumio volumio[27751]: info: -------------------------------------------
Apr 04 03:03:51 volumio volumio[27751]: info: Loading plugins from folder /volumio/app/plugins/
Apr 04 03:03:51 volumio volumio[27751]: info: Adding plugin upnp to MyMusic Plugins
Apr 04 03:03:51 volumio volumio[27751]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 04 03:03:51 volumio volumio[27751]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 04 03:03:51 volumio volumio[27751]: info: Loading plugins from folder /data/plugins/
Apr 04 03:03:51 volumio volumio[27751]: info: Adding plugin rtlsdr_radio to MyMusic Plugins
Apr 04 03:03:51 volumio volumio[27751]: info: Loading plugin "system"...
Apr 04 03:03:51 volumio volumio[27751]: info: Loading plugin "appearance"...
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "network"...
Apr 04 03:03:52 volumio volumio[27751]: info: Refreshing Cached IP Addresses
Apr 04 03:03:52 volumio sudo[27781]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 03:03:52 volumio sudo[27781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:52 volumio sudo[27781]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:52 volumio sudo[27783]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 03:03:52 volumio sudo[27783]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "services"...
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "volumio5onboarding"...
Apr 04 03:03:52 volumio sudo[27783]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:52 volumio sudo[27791]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 04 03:03:52 volumio sudo[27791]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "alsa_controller"...
Apr 04 03:03:52 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "wizard"...
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "networkfs"...
Apr 04 03:03:52 volumio volumio[27751]: info: Cannot mount NAS DJA at system boot, trial number 1 ,retrying in 5 seconds
Apr 04 03:03:52 volumio volumio[27751]: info: Starting Udev Watcher for removable devices
Apr 04 03:03:52 volumio volumio[27751]: info: Ignoring mount for partition: boot
Apr 04 03:03:52 volumio volumio[27751]: info: Ignoring mount for partition: volumio
Apr 04 03:03:52 volumio volumio[27751]: info: Ignoring mount for partition: volumio_data
Apr 04 03:03:52 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "volumio_command_line_client"...
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "upnp"...
Apr 04 03:03:52 volumio volumio[27751]: info: [1775264632811] Starting Upmpd Daemon
Apr 04 03:03:52 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "my_music"...
Apr 04 03:03:52 volumio volumio[27751]: info: Loading plugin "mpd"...
Apr 04 03:03:53 volumio volumio[27751]: info: Loading plugin "upnp_browser"...
Apr 04 03:03:53 volumio sudo[27791]: pam_unix(sudo:session): session closed for user root
Apr 04 03:03:54 volumio volumio[27751]: info: Starting UPNP Browser
Apr 04 03:03:54 volumio volumio[27751]: info: Loading plugin "alarm-clock"...
Apr 04 03:03:54 volumio volumio[27751]: info: Loading plugin "airplay_emulation"...
Apr 04 03:03:54 volumio volumio[27751]: info: Starting Shairport Sync
Apr 04 03:03:54 volumio volumio[27751]: info: Loading plugin "last_100"...
Apr 04 03:03:54 volumio volumio[27751]: info: Loading plugin "webradio"...
Apr 04 03:03:55 volumio volumio[27751]: info: Loading plugin "i2s_dacs"...
Apr 04 03:03:55 volumio volumio[27751]: info: Loading plugin "volumiodiscovery"...
Apr 04 03:03:55 volumio volumio[27751]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:55 volumio volumio[27751]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:55 volumio volumio[27751]: *** WARNING *** For more information see
Apr 04 03:03:55 volumio volumio[27751]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:55 volumio volumio[27751]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:55 volumio volumio[27751]: *** WARNING *** For more information see
Apr 04 03:03:55 volumio node[27751]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:55 volumio node[27751]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:55 volumio node[27751]: *** WARNING *** For more information see
Apr 04 03:03:55 volumio node[27751]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 04 03:03:55 volumio node[27751]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 03:03:55 volumio node[27751]: *** WARNING *** For more information see
Apr 04 03:03:55 volumio volumio[27751]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 04 03:03:55 volumio volumio[27751]: info: Discovery: Started advertising with name: Volumio
Apr 04 03:03:55 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 03:03:55 volumio volumio[27751]: info: Loading plugin "bandcamp"...
Apr 04 03:03:55 volumio volumio-remote-updater[736]: [2026-04-04 03:03:55] [connect] Successful connection
Apr 04 03:03:56 volumio volumio[27751]: info: Loading plugin "calmradio"...
Apr 04 03:03:57 volumio volumio[27751]: info: Loading plugin "soundcloud"...
Apr 04 03:03:58 volumio volumio[27751]: info: Loading plugin "squeezelite_mc"...
Apr 04 03:03:58 volumio wpa_supplicant[1135]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="DSDK"
Apr 04 03:03:58 volumio wpa_supplicant[1135]: wlan0: Trying to associate with 80:2a:a8:11:32:52 (SSID='DSDK' freq=2427 MHz)
Apr 04 03:03:58 volumio volumio[27751]: info: Loading plugin "SleepWakePlugin"...
Apr 04 03:03:59 volumio wpa_supplicant[1135]: wlan0: Associated with 80:2a:a8:11:32:52
Apr 04 03:03:59 volumio wpa_supplicant[1135]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 04 03:03:59 volumio wpa_supplicant[1135]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=SG
Apr 04 03:03:59 volumio wpa_supplicant[1135]: wlan0: WPA: Key negotiation completed with 80:2a:a8:11:32:52 [PTK=CCMP GTK=CCMP]
Apr 04 03:03:59 volumio wpa_supplicant[1135]: wlan0: CTRL-EVENT-CONNECTED - Connection to 80:2a:a8:11:32:52 completed [id=0 id_str=]
Apr 04 03:03:59 volumio dhcpcd[757]: wlan0: carrier acquired
Apr 04 03:03:59 volumio dhcpcd[757]: wlan0: IAID eb:30:8a:e3
Apr 04 03:03:59 volumio volumio[27751]: info: Applying required configuration parameters for plugin SleepWakePlugin
Apr 04 03:03:59 volumio volumio[27751]: info: SleepWakePlugin - onVolumioStart
Apr 04 03:03:59 volumio volumio[27751]: info: Loading plugin "outputs"...
Apr 04 03:03:59 volumio volumio[27751]: info: Loading plugin "albumart"...
Apr 04 03:03:59 volumio volumio[27751]: info: Plugin example_plugin is not enabled
Apr 04 03:03:59 volumio volumio[27751]: info: Loading plugin "inputs"...
Apr 04 03:03:59 volumio volumio[27751]: info: Loading plugin "updater_comm"...
Apr 04 03:03:59 volumio volumio[27751]: info: Plugin mpdemulation is not enabled
Apr 04 03:03:59 volumio volumio[27751]: info: Loading plugin "rest_api"...
Apr 04 03:03:59 volumio volumio[27751]: info: Loading plugin "websocket"...
Apr 04 03:03:59 volumio volumio[27751]: info: Starting Socket.io Server version 1.7.4
Apr 04 03:03:59 volumio volumio[27751]: info: Loading plugin "fusiondsp"...
Apr 04 03:03:59 volumio dhcpcd[757]: wlan0: soliciting an IPv6 router
Apr 04 03:03:59 volumio volumio[27817]: Forking 3 albumart workers
Apr 04 03:03:59 volumio volumio[27751]: info: Applying required configuration parameters for plugin fusiondsp
Apr 04 03:04:00 volumio volumio[27751]: info: Loading plugin "mpdoutput"...
Apr 04 03:04:00 volumio volumio[27751]: info: Loading plugin "80s80s"...
Apr 04 03:04:00 volumio volumio5-onboarding[2096]: time=2026-04-04T03:04:00.426+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:47180->127.0.0.1:3000: i/o timeout"
Apr 04 03:04:00 volumio dhcpcd[757]: wlan0: rebinding lease of 192.168.1.210
Apr 04 03:04:00 volumio dhcpcd[757]: wlan0: probing address 192.168.1.210/24
Apr 04 03:04:00 volumio volumio[27751]: info: Applying required configuration parameters for plugin 80s80s
Apr 04 03:04:00 volumio volumio[27751]: info: [1775264640872] [80s80s] API delay: 30
Apr 04 03:04:00 volumio volumio[27751]: info: Loading plugin "RoonBridge"...
Apr 04 03:04:01 volumio volumio[27751]: info: Applying required configuration parameters for plugin RoonBridge
Apr 04 03:04:01 volumio volumio[27751]: info: Loading plugin "motherearthradio"...
Apr 04 03:04:01 volumio volumio[27827]: Starting albumart workers
Apr 04 03:04:01 volumio volumio[27828]: Starting albumart workers
Apr 04 03:04:01 volumio volumio[27751]: info: Applying required configuration parameters for plugin motherearthradio
Apr 04 03:04:01 volumio volumio[27751]: info: [1775264641476] [MotherEarth] API delay: 5
Apr 04 03:04:01 volumio volumio[27751]: info: Loading plugin "radio_paradise"...
Apr 04 03:04:01 volumio volumio[27829]: Starting albumart workers
Apr 04 03:04:01 volumio volumio[27751]: info: Applying required configuration parameters for plugin radio_paradise
Apr 04 03:04:01 volumio volumio[27751]: info: [1775264641881] [RadioParadise] API delay: 5
Apr 04 03:04:01 volumio volumio[27751]: info: Loading plugin "rtlsdr_radio"...
Apr 04 03:04:02 volumio volumio[27751]: info: Loading i18n strings for locale it
Apr 04 03:04:02 volumio volumio[27751]: Updating browse sources language
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::initPlayerControls
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:04:02 volumio volumio[27751]: Express server listening on port 3000
Apr 04 03:04:02 volumio volumio[27751]: [Metrics] WebUI: 12s 864.60ms
Apr 04 03:04:02 volumio volumio[27751]: info: CoreStateMachine::resetVolumioState
Apr 04 03:04:02 volumio volumio[27751]: info: CoreStateMachine::getcurrentVolume
Apr 04 03:04:02 volumio volumio[27751]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:04:02 volumio volumio[27751]: info: Cannot mount NAS DJA at system boot, trial number 2 ,retrying in 5 seconds
Apr 04 03:04:03 volumio sudo[27896]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 03:04:03 volumio sudo[27896]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:03 volumio sudo[27896]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:03 volumio sudo[27898]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 03:04:03 volumio sudo[27898]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:03 volumio sudo[27898]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:03 volumio volumio[27751]: info: Volumio Network Manager: Network status updated: 0
Apr 04 03:04:03 volumio volumio[27751]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:04:03 volumio volumio[27751]: info: CoreStateMachine::pushState
Apr 04 03:04:03 volumio volumio[27751]: info: CorePlayQueue::getTrack 0
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioPushState
Apr 04 03:04:03 volumio volumio[27751]: info: CoreStateMachine::updateTrackBlock
Apr 04 03:04:03 volumio volumio[27751]: info: CorePlayQueue::getTrackBlock
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:04:03 volumio volumio[27751]: info: Reloading queue from file
Apr 04 03:04:03 volumio volumio[27751]: 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
Apr 04 03:04:03 volumio volumio[27751]: info: CoreStateMachine::setRepeat false single undefined
Apr 04 03:04:03 volumio volumio[27751]: info: CoreStateMachine::pushState
Apr 04 03:04:03 volumio volumio[27751]: info: CorePlayQueue::getTrack 0
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioPushState
Apr 04 03:04:03 volumio volumio[27751]: info: CoreStateMachine::setRandom undefined
Apr 04 03:04:03 volumio volumio[27751]: info: CoreStateMachine::pushState
Apr 04 03:04:03 volumio volumio[27751]: info: CorePlayQueue::getTrack 0
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioPushState
Apr 04 03:04:03 volumio volumio[27751]: info: Setting Device type: Raspberry PI
Apr 04 03:04:03 volumio volumio[27751]: info: Completed loading Core Plugins
Apr 04 03:04:03 volumio volumio[27751]: info: Preparing to generate the ALSA configuration file
Apr 04 03:04:03 volumio volumio[27751]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 04 03:04:03 volumio volumio[27751]: info: Reading ALSA contributions from plugins.
Apr 04 03:04:03 volumio volumio[27751]: 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
Apr 04 03:04:03 volumio volumio[27751]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:04:03 volumio volumio[27751]: info: CoreStateMachine::pushState
Apr 04 03:04:03 volumio volumio[27751]: info: CorePlayQueue::getTrack 0
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioPushState
Apr 04 03:04:03 volumio sudo[27912]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 04 03:04:03 volumio sudo[27912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:03 volumio volumio[27751]: 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
Apr 04 03:04:03 volumio volumio[27751]: info: Received Get System Info
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 04 03:04:03 volumio volumio[27751]: info: Discovery: Getting this device information
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioGetState
Apr 04 03:04:03 volumio volumio[27751]: info: CorePlayQueue::getTrack 0
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 04 03:04:03 volumio volumio[27751]: info: Received Get System Info
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 04 03:04:03 volumio volumio[27751]: info: Discovery: Getting this device information
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioGetState
Apr 04 03:04:03 volumio volumio[27751]: info: CorePlayQueue::getTrack 0
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 04 03:04:03 volumio sudo[27912]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 04 03:04:03 volumio volumio[27751]: info: Discovery: adding c69f8783-26e2-48e2-a8ae-e3cb917f598f
Apr 04 03:04:03 volumio volumio[27751]: info: Discovery: Found device Volumio
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioGetState
Apr 04 03:04:03 volumio volumio[27751]: info: CorePlayQueue::getTrack 0
Apr 04 03:04:03 volumio volumio[27751]: info: Upmpdcli Daemon Started
Apr 04 03:04:03 volumio volumio[27751]: info: Asound.conf file unchanged, so no further update is needed
Apr 04 03:04:03 volumio volumio[27751]: info: Output device has changed, restarting MPD
Apr 04 03:04:03 volumio volumio[27751]: info: Output device has changed, restarting Shairport Sync
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:04:03 volumio sudo[27917]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 03:04:03 volumio sudo[27917]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:03 volumio sudo[27919]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 03:04:03 volumio sudo[27919]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:03 volumio sudo[27917]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:03 volumio volumio[27751]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:04:03 volumio volumio[27751]: info: ___________ START PLUGINS ___________
Apr 04 03:04:03 volumio volumio[27751]: info: ControllerMpd::onStart: Initializing MPD
Apr 04 03:04:03 volumio volumio[27751]: info: Creating MPD Configuration file
Apr 04 03:04:03 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Apr 04 03:04:03 volumio sudo[27927]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Apr 04 03:04:03 volumio sudo[27927]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:03 volumio volumio[27751]: info: [1775264643650] CoreMusicLibrary::Adding element Server multimediali
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:03 volumio sudo[27929]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 03:04:03 volumio sudo[27929]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:03 volumio sudo[27929]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:03 volumio sudo[27932]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 03:04:03 volumio sudo[27932]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:03 volumio sudo[27927]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:03 volumio volumio[27751]: info: UPNP Browser: Client initialized successfully
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:04:03 volumio systemd[1]: mpd.service: Deactivated successfully.
Apr 04 03:04:03 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Apr 04 03:04:03 volumio systemd[1]: mpd.service: Consumed 3.816s CPU time.
Apr 04 03:04:03 volumio systemd[1]: mpd.socket: Deactivated successfully.
Apr 04 03:04:03 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Apr 04 03:04:03 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Apr 04 03:04:03 volumio volumio[27751]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:04:03 volumio volumio[27751]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:03 volumio volumio[27751]: info: [1775264643803] CoreMusicLibrary::Adding element Last_100
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:03 volumio volumio[27751]: info: [1775264643806] CoreMusicLibrary::Adding element Webradio
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:04:03 volumio volumio[27751]: info: Initializing BBC Radios
Apr 04 03:04:03 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Apr 04 03:04:03 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Apr 04 03:04:03 volumio systemd[1]: mpd.service: Deactivated successfully.
Apr 04 03:04:03 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Apr 04 03:04:03 volumio systemd[1]: mpd.socket: Deactivated successfully.
Apr 04 03:04:03 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Apr 04 03:04:03 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 03:04:03 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:03 volumio volumio[27751]: info: [1775264643894] CoreMusicLibrary::Adding element Bandcamp Discover
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:03 volumio volumio[27751]: Cannot find translation for source Bandcamp Discover
Apr 04 03:04:03 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Apr 04 03:04:03 volumio volumio[27751]: info: Adding Calm Radio to Browse Sources
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:03 volumio volumio[27751]: info: [1775264643909] CoreMusicLibrary::Adding element Calm Radio
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:03 volumio volumio[27751]: Cannot find translation for source Bandcamp Discover
Apr 04 03:04:03 volumio volumio[27751]: Cannot find translation for source Calm Radio
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:03 volumio volumio[27751]: info: [1775264643925] CoreMusicLibrary::Adding element SoundCloud
Apr 04 03:04:03 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:03 volumio volumio[27751]: Cannot find translation for source Bandcamp Discover
Apr 04 03:04:03 volumio volumio[27751]: Cannot find translation for source Calm Radio
Apr 04 03:04:03 volumio volumio[27751]: Cannot find translation for source SoundCloud
Apr 04 03:04:03 volumio volumio[27751]: info: [squeezelite_mc] Starting proxy server...
Apr 04 03:04:03 volumio volumio[27751]: info: SleepWakePlugin - onStart
Apr 04 03:04:03 volumio volumio[27751]: info: SleepWakePlugin - Sleep scheduled in 78956035 milliseconds
Apr 04 03:04:03 volumio volumio[27751]: info: SleepWakePlugin - Wake scheduled in 14156031 milliseconds
Apr 04 03:04:04 volumio volumio[27751]: info: FusionDsp - CamillaDSP binary found.
Apr 04 03:04:04 volumio volumio[27751]: info: Loading i18n strings for locale it
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:04 volumio volumio[27751]: info: FusionDsp - mixtype--------------------- Hardware
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:04 volumio volumio[27751]: info: [1775264644052] CoreMusicLibrary::Adding element 80s80s Radio
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Bandcamp Discover
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Calm Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source SoundCloud
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source 80s80s Radio
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:04 volumio volumio[27751]: info: [1775264644079] CoreMusicLibrary::Adding element Mother Earth Radio
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Bandcamp Discover
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Calm Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source SoundCloud
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source 80s80s Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Mother Earth Radio
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:04 volumio volumio[27751]: info: [1775264644090] CoreMusicLibrary::Adding element Radio Paradise
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:04 volumio sudo[27961]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Bandcamp Discover
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Calm Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source SoundCloud
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source 80s80s Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Mother Earth Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Radio Paradise
Apr 04 03:04:04 volumio sudo[27961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Starting plugin
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Loaded i18n strings for language: it
Apr 04 03:04:04 volumio volumio[27751]: info: Volumio Calling Home
Apr 04 03:04:04 volumio sudo[27961]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:04 volumio sudo[27959]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 04 03:04:04 volumio sudo[27959]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 04 03:04:04 volumio sudo[27959]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:04 volumio volumio[27751]: info: [squeezelite_mc] Proxy server started on port 38569
Apr 04 03:04:04 volumio volumio[27751]: info: Preparing to generate the ALSA configuration file
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] snd-aloop already loaded
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Database version: 2
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Loaded v2 database successfully
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Database loaded at: 2026-04-04T01:04:04.356Z
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Loading blocklist from: /data/plugins/music_service/rtlsdr_radio/blocklist.json
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Got 21 phrases from file
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Updated metadata blocklist
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Metadata module now has 21 phrases
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Management server started on port 3456
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 03:04:04 volumio volumio[27751]: info: [1775264644536] CoreMusicLibrary::Adding element FM/DAB Radio
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Bandcamp Discover
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Calm Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source SoundCloud
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source 80s80s Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Mother Earth Radio
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source Radio Paradise
Apr 04 03:04:04 volumio volumio[27751]: Cannot find translation for source FM/DAB Radio
Apr 04 03:04:04 volumio volumio[27751]: info: [RTL-SDR Radio] Plugin started successfully
Apr 04 03:04:04 volumio volumio[27751]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 03:04:04 volumio volumio[27751]: Unhandled rejection Error: No sockets available, cannot start.
Apr 04 03:04:04 volumio volumio[27751]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Apr 04 03:04:04 volumio volumio[27751]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Apr 04 03:04:04 volumio volumio[27751]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Apr 04 03:04:04 volumio volumio[27751]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Apr 04 03:04:04 volumio volumio[27751]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Apr 04 03:04:04 volumio volumio[27751]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Apr 04 03:04:04 volumio volumio[27751]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Apr 04 03:04:04 volumio volumio[27751]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Apr 04 03:04:04 volumio volumio[27751]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14)
Apr 04 03:04:04 volumio volumio[27751]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Apr 04 03:04:04 volumio volumio[27751]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Apr 04 03:04:04 volumio volumio[27751]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Apr 04 03:04:04 volumio volumio[27751]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Apr 04 03:04:04 volumio volumio[27751]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Apr 04 03:04:04 volumio volumio[27751]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Apr 04 03:04:04 volumio volumio[27751]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 04 03:04:04 volumio volumio[27751]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 04 03:04:04 volumio volumio[27751]: info: Reading ALSA contributions from plugins.
Apr 04 03:04:05 volumio volumio[27751]: info: MPD Permissions set
Apr 04 03:04:05 volumio volumio[27751]: info: MPD Permissions set
Apr 04 03:04:05 volumio volumio[27751]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Apr 04 03:04:05 volumio volumio[27751]: info: VolumeController:: Volume=29 Mute =false
Apr 04 03:04:05 volumio volumio[27751]: info: CoreStateMachine::pushState
Apr 04 03:04:05 volumio volumio[27751]: info: CorePlayQueue::getTrack 0
Apr 04 03:04:05 volumio volumio[27751]: info: CoreCommandRouter::volumioPushState
Apr 04 03:04:05 volumio volumio[27751]: info: [squeezelite_mc] Server discovery started
Apr 04 03:04:05 volumio volumio[27751]: info: [squeezelite_mc] Player finder started
Apr 04 03:04:05 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:05 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:05 volumio volumio[27751]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 03:04:05 volumio volumio[27751]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"","card":"4","mixerType":"Hardware","mixer":"Digital"}
Apr 04 03:04:05 volumio volumio[27751]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Apr 04 03:04:05 volumio volumio[27751]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 03:04:05 volumio volumio[27751]: Error: send ENETUNREACH 255.255.255.255:3483
Apr 04 03:04:05 volumio volumio[27751]: at doSend (node:dgram:717:16)
Apr 04 03:04:05 volumio volumio[27751]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18)
Apr 04 03:04:05 volumio volumio[27751]: at afterDns (node:dgram:663:5)
Apr 04 03:04:05 volumio volumio[27751]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) {
Apr 04 03:04:05 volumio volumio[27751]: errno: -101,
Apr 04 03:04:05 volumio volumio[27751]: code: 'ENETUNREACH',
Apr 04 03:04:05 volumio volumio[27751]: syscall: 'send',
Apr 04 03:04:05 volumio volumio[27751]: address: '255.255.255.255',
Apr 04 03:04:05 volumio volumio[27751]: port: 3483
Apr 04 03:04:05 volumio volumio[27751]: }
Apr 04 03:04:05 volumio volumio[27751]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 03:04:05 volumio sudo[27977]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Apr 04 03:04:05 volumio sudo[27977]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:05 volumio sudo[27977]: pam_unix(sudo:session): session closed for user root
Apr 04 03:04:05 volumio volumio5-onboarding[2096]: time=2026-04-04T03:04:05.258+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 04 03:04:05 volumio sudo[27993]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-04 03:03'
Apr 04 03:04:05 volumio sudo[27993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 04 03:04:06 volumio dhcpcd[757]: wlan0: leased 192.168.1.210 for 3600 seconds
Apr 04 03:04:06 volumio avahi-daemon[1291]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.210.
Apr 04 03:04:06 volumio avahi-daemon[1291]: New relevant interface wlan0.IPv4 for mDNS.
Apr 04 03:04:06 volumio avahi-daemon[1291]: Registering new address record for 192.168.1.210 on wlan0.IPv4.
Apr 04 03:04:06 volumio dhcpcd[757]: wlan0: adding route to 192.168.1.0/24
Apr 04 03:04:06 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 04 03:04:06 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0...
Apr 04 03:04:06 volumio systemd[1]: welcome.service: Deactivated successfully.
Apr 04 03:04:06 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Apr 04 03:04:06 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Apr 04 03:04:06 volumio dhcpcd[757]: wlan0: adding default route via 192.168.1.1
Apr 04 03:04:06 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Apr 04 03:04:06 volumio welcome[28004]: Resolved ip:[1] 192.168.1.210
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"