-- Logs begin at Tue 2025-05-13 08:34:22 +07, end at Tue 2025-05-13 09:04:42 +07. --
May 13 09:03:00 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:00 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:00 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:03 volumio volumio[2793]: info: Loading plugin "ytmusic"...
May 13 09:03:05 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:05 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:05 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:05 volumio volumio[2793]: info: Loading plugin "autostart"...
May 13 09:03:05 volumio volumio[2793]: info: Applying required configuration parameters for plugin autostart
May 13 09:03:05 volumio volumio[2793]: info: AutoStart - onVolumioStart - read config.json
May 13 09:03:05 volumio volumio[2793]: info: Loading plugin "now_playing"...
May 13 09:03:06 volumio volumio[2793]: info: Loading plugin "outputs"...
May 13 09:03:06 volumio volumio[2793]: info: Loading plugin "albumart"...
May 13 09:03:06 volumio volumio[2793]: info: Plugin example_plugin is not enabled
May 13 09:03:06 volumio volumio[2793]: info: Loading plugin "inputs"...
May 13 09:03:06 volumio volumio[2793]: info: Loading plugin "updater_comm"...
May 13 09:03:06 volumio volumio[2793]: info: Plugin mpdemulation is not enabled
May 13 09:03:06 volumio volumio[2793]: info: Loading plugin "rest_api"...
May 13 09:03:06 volumio volumio[2793]: info: Loading plugin "websocket"...
May 13 09:03:06 volumio volumio[2793]: Forking 3 albumart workers
May 13 09:03:06 volumio volumio[2793]: info: Starting Socket.io Server version 2.3.0
May 13 09:03:06 volumio volumio[2793]: info: Loading plugin "fusiondsp"...
May 13 09:03:07 volumio volumio[2793]: info: Applying required configuration parameters for plugin fusiondsp
May 13 09:03:07 volumio volumio[2793]: info: Loading plugin "mpdoutput"...
May 13 09:03:07 volumio volumio[2793]: info: Loading plugin "RoonBridge"...
May 13 09:03:07 volumio volumio[2793]: Starting albumart workers
May 13 09:03:07 volumio volumio[2793]: Starting albumart workers
May 13 09:03:08 volumio volumio[2793]: info: Applying required configuration parameters for plugin RoonBridge
May 13 09:03:08 volumio volumio[2793]: info: Loading plugin "minidlna"...
May 13 09:03:08 volumio volumio[2793]: info: Applying required configuration parameters for plugin minidlna
May 13 09:03:08 volumio volumio[2793]: Starting albumart workers
May 13 09:03:08 volumio volumio[2793]: info: Loading plugin "myb"...
May 13 09:03:08 volumio volumio[2793]: info: Applying required configuration parameters for plugin myb
May 13 09:03:08 volumio volumio[2793]: info: Loading plugin "pandora"...
May 13 09:03:08 volumio volumio-remote-updater[817]: [2025-05-13 09:03:08] [connect] Successful connection
May 13 09:03:09 volumio volumio[2793]: info: Applying required configuration parameters for plugin pandora
May 13 09:03:09 volumio volumio[2793]: info: Loading plugin "podcast"...
May 13 09:03:09 volumio volumio[2793]: info: ControllerPodcast::constructor
May 13 09:03:09 volumio volumio[2793]: info: Loading plugin "swarmstation"...
May 13 09:03:09 volumio volumio[2793]: info: Applying required configuration parameters for plugin swarmstation
May 13 09:03:09 volumio volumio[2793]: info: [1747101789901] [Swarmstation] API delay: 5
May 13 09:03:09 volumio volumio[2793]: info: Loading plugin "volusonic"...
May 13 09:03:10 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:10 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:10 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:10 volumio volumio[2793]: info: Applying required configuration parameters for plugin volusonic
May 13 09:03:10 volumio volumio[2793]: info: Plugin peppymeterbasic is not enabled
May 13 09:03:10 volumio volumio[2793]: info: Loading plugin "backup_restore"...
May 13 09:03:10 volumio volumio[2793]: info: Applying required configuration parameters for plugin backup_restore
May 13 09:03:10 volumio volumio[2793]: info: Loading plugin "music_services_shield"...
May 13 09:03:11 volumio volumio[2793]: info: Applying required configuration parameters for plugin music_services_shield
May 13 09:03:11 volumio volumio[2793]: info: Loading plugin "Systeminfo"...
May 13 09:03:11 volumio volumio[2793]: info: Loading plugin "peppyspectrum"...
May 13 09:03:11 volumio volumio[2793]: info: Loading plugin "randomizer"...
May 13 09:03:11 volumio volumio[2793]: info: Applying required configuration parameters for plugin randomizer
May 13 09:03:11 volumio volumio[2793]: info: Loading i18n strings for locale vi
May 13 09:03:11 volumio volumio[2793]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:03:11 volumio volumio[2793]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:03:11 volumio volumio[2793]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:03:11 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:03:11 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:03:11 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:03:11 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:03:11 volumio volumio[2793]: Updating browse sources language
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::initPlayerControls
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:03:11 volumio volumio[2793]: Express server listening on port 3000
May 13 09:03:11 volumio volumio[2793]: [Metrics] WebUI: 19s 653.99ms
May 13 09:03:11 volumio volumio[2793]: info: Setting Device type: x86
May 13 09:03:11 volumio volumio[2793]: info: CoreStateMachine::resetVolumioState
May 13 09:03:11 volumio volumio[2793]: info: CoreStateMachine::getcurrentVolume
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::volumioRetrievevolume
May 13 09:03:11 volumio volumio[2793]: info: CoreStateMachine::pushState
May 13 09:03:11 volumio volumio[2793]: info: CorePlayQueue::getTrack 0
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::volumioPushState
May 13 09:03:11 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:12 volumio sudo[2978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 13 09:03:12 volumio sudo[2978]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio sudo[2978]: pam_unix(sudo:session): session closed for user root
May 13 09:03:12 volumio volumio[2793]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
May 13 09:03:12 volumio volumio[2793]: info: Completed loading Core Plugins
May 13 09:03:12 volumio sudo[2981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 13 09:03:12 volumio volumio[2793]: info: Preparing to generate the ALSA configuration file
May 13 09:03:12 volumio sudo[2981]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio sudo[2981]: pam_unix(sudo:session): session closed for user root
May 13 09:03:12 volumio volumio[2793]: info: Volumio Network Manager: Network status updated: 0
May 13 09:03:12 volumio volumio[2793]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
May 13 09:03:12 volumio volumio[2793]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 13 09:03:12 volumio volumio[2793]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
May 13 09:03:12 volumio volumio[2793]: info: Reading ALSA contributions from plugins.
May 13 09:03:12 volumio volumio-remote-updater[817]: [2025-05-13 09:03:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747101788 101
May 13 09:03:12 volumio volumio[2793]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1
May 13 09:03:12 volumio volumio[2793]: info: Cannot read play queue from file
May 13 09:03:12 volumio volumio[2793]: info: CoreStateMachine::setRepeat true single undefined
May 13 09:03:12 volumio volumio[2793]: info: CoreStateMachine::pushState
May 13 09:03:12 volumio volumio[2793]: info: CorePlayQueue::getTrack 0
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::volumioPushState
May 13 09:03:12 volumio volumio[2793]: info: CoreStateMachine::setRandom true
May 13 09:03:12 volumio volumio[2793]: info: CoreStateMachine::pushState
May 13 09:03:12 volumio volumio[2793]: info: CorePlayQueue::getTrack 0
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::volumioPushState
May 13 09:03:12 volumio volumio[2793]: info: Asound.conf file unchanged, so no further update is needed
May 13 09:03:12 volumio volumio[2793]: info: Output device has changed, restarting MPD
May 13 09:03:12 volumio sudo[2988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 13 09:03:12 volumio sudo[2988]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio sudo[2988]: pam_unix(sudo:session): session closed for user root
May 13 09:03:12 volumio sudo[2991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 09:03:12 volumio sudo[2991]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio sudo[2991]: pam_unix(sudo:session): session closed for user root
May 13 09:03:12 volumio volumio[2793]: info: Output device has changed, restarting Shairport Sync
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:12 volumio sudo[2994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 09:03:12 volumio sudo[2994]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio systemd[1]: musicservicesshield.service: Succeeded.
May 13 09:03:12 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
May 13 09:03:12 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
May 13 09:03:12 volumio systemd[1]: Stopping Music Player Daemon...
May 13 09:03:12 volumio systemd[1]: mpd.service: Succeeded.
May 13 09:03:12 volumio systemd[1]: Stopped Music Player Daemon.
May 13 09:03:12 volumio volumio[2793]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:03:12 volumio systemd[1]: Starting Music Player Daemon...
May 13 09:03:12 volumio volumio[2793]: info: ___________ START PLUGINS ___________
May 13 09:03:12 volumio volumio[2793]: info: ControllerMpd::onStart: Initializing MPD
May 13 09:03:12 volumio volumio[2793]: info: Creating MPD Configuration file
May 13 09:03:12 volumio sudo[3001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 09:03:12 volumio sudo[3001]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio sudo[3001]: pam_unix(sudo:session): session closed for user root
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:03:12 volumio sudo[2999]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 13 09:03:12 volumio sudo[2999]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:12 volumio volumio[2793]: info: [1747101792745] CoreMusicLibrary::Adding element Máy chủ Media
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:12 volumio sudo[2999]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 13 09:03:12 volumio sudo[2999]: pam_unix(sudo:session): session closed for user root
May 13 09:03:12 volumio sudo[3004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 09:03:12 volumio sudo[3004]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:12 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 13 09:03:12 volumio systemd[1]: mpd.service: Succeeded.
May 13 09:03:12 volumio systemd[1]: Stopped Music Player Daemon.
May 13 09:03:12 volumio systemd[1]: Starting Music Player Daemon...
May 13 09:03:12 volumio volumio[2793]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:12 volumio sudo[3009]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 13 09:03:12 volumio sudo[3009]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:12 volumio sudo[3009]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 13 09:03:12 volumio sudo[3009]: pam_unix(sudo:session): session closed for user root
May 13 09:03:12 volumio volumio[2793]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:12 volumio volumio[2793]: info: [1747101792987] CoreMusicLibrary::Adding element Last_100
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:12 volumio volumio[2793]: info: [1747101792990] CoreMusicLibrary::Adding element Webradio
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:12 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:03:12 volumio volumio[2793]: info: Initializing BBC Radios
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 13 09:03:13 volumio volumio[2793]: info: Discovery: Getting this device information
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioGetState
May 13 09:03:13 volumio volumio[2793]: info: CorePlayQueue::getTrack 0
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:13 volumio volumio[2793]: info: [1747101793215] CoreMusicLibrary::Adding element Jellyfin
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: info: [jellyfin] Initialized plugin with device info: {"id":"88b6c06e-9c07-4af1-b4f1-01959a64deb2","host":"http://127.0.0.1","name":"Volumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":100,"mute":false,"artist":"","track":"","albumart":"http://127.0.0.1/albumart"}}
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:13 volumio volumio[2793]: info: [1747101793232] CoreMusicLibrary::Adding element SoundCloud
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: info: Creating Spotify config file
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:13 volumio volumio[2793]: info: [squeezelite_mc] Starting proxy server...
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:13 volumio volumio[2793]: info: [1747101793380] CoreMusicLibrary::Adding element YouTube2
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:13 volumio volumio[2793]: info: [1747101793434] CoreMusicLibrary::Adding element YouTube Music
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube Music
May 13 09:03:13 volumio volumio[2793]: info: AutoStart - onStart
May 13 09:03:13 volumio volumio[2793]: info: [now-playing] ConfigUpdater: config is up to date.
May 13 09:03:13 volumio volumio[2793]: info: Loading i18n strings for locale vi
May 13 09:03:13 volumio volumio[2793]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:03:13 volumio volumio[2793]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:13 volumio volumio[2793]: info: FusionDsp - mixtype--------------------- None
May 13 09:03:13 volumio volumio[2793]: info: Loading i18n strings for locale vi
May 13 09:03:13 volumio volumio[2793]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:03:13 volumio volumio[2793]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:03:13 volumio sudo[3028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
May 13 09:03:13 volumio sudo[3028]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:13 volumio sudo[3028]: pam_unix(sudo:session): session closed for user root
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:13 volumio volumio[2793]: info: [1747101793650] CoreMusicLibrary::Adding element Pandora Radio
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube Music
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Pandora Radio
May 13 09:03:13 volumio volumio[2793]: info: [1747101793659] ControllerPandora::initializeMQTT
May 13 09:03:13 volumio volumio[2793]: info: [1747101793661] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:13 volumio volumio[2793]: info: [1747101793670] CoreMusicLibrary::Adding element Podcast
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube Music
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Pandora Radio
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Podcast
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:13 volumio volumio[2793]: info: [1747101793682] CoreMusicLibrary::Adding element SWARM Station
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube Music
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Pandora Radio
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Podcast
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SWARM Station
May 13 09:03:13 volumio volumio[2793]: info: Loading i18n strings for locale vi
May 13 09:03:13 volumio volumio[2793]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:03:13 volumio volumio[2793]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:03:13 volumio volumio[2793]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:03:13 volumio volumio[2793]: Updating browse sources language
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube Music
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Pandora Radio
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Podcast
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SWARM Station
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube Music
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Pandora Radio
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Podcast
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SWARM Station
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:13 volumio volumio[2793]: info: [1747101793769] CoreMusicLibrary::Adding element Volusonic
May 13 09:03:13 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source YouTube Music
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Pandora Radio
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Podcast
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source SWARM Station
May 13 09:03:13 volumio volumio[2793]: Cannot find translation for source Volusonic
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 13 09:03:14 volumio sudo[3060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:14 volumio volumio[2793]: info: [1747101794361] CoreMusicLibrary::Adding element Randomizer
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source Jellyfin
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source SoundCloud
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source YouTube2
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source YouTube Music
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source Pandora Radio
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source Podcast
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source SWARM Station
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source Volusonic
May 13 09:03:14 volumio volumio[2793]: Cannot find translation for source Randomizer
May 13 09:03:14 volumio sudo[3060]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:14 volumio volumio[2793]: info: Volumio Calling Home
May 13 09:03:14 volumio volumio[2793]: info: [squeezelite_mc] Proxy server started on port 35499
May 13 09:03:14 volumio volumio[2793]: info: Preparing to generate the ALSA configuration file
May 13 09:03:14 volumio volumio[2793]: info: [1747101794634] ControllerPandora::initialSetup
May 13 09:03:14 volumio volumio[2793]: info: [1747101794644] ControllerPandora::PandoraHandler::init
May 13 09:03:14 volumio volumio[2793]: info: [1747101794645] ControllerPandora::PandoraHandler::loadErrorCodes
May 13 09:03:14 volumio mpd[3016]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 13 09:03:14 volumio mpd[3016]: output: No 'audio_output' defined in config file
May 13 09:03:14 volumio volumio[2793]: info: [1747101794734] [Pandora] PandoraHandler::setMaxStationTracks: 16
May 13 09:03:14 volumio volumio[2793]: info: [1747101794737] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty
May 13 09:03:14 volumio volumio[2793]: info: [1747101794739] ControllerPandora::flushPandora
May 13 09:03:14 volumio volumio[2793]: info: CorePlayQueue::getQueue
May 13 09:03:14 volumio volumio[2793]: info: CorePlayQueue::clearPlayQueue
May 13 09:03:14 volumio volumio[2793]: info: CorePlayQueue::saveQueue
May 13 09:03:14 volumio mpd[3016]: couldn't open play stream: No such file or directory
May 13 09:03:14 volumio mpd[3016]: sndio_output: Error opening default sndio device
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::volumioPushQueue
May 13 09:03:14 volumio mpd[3016]: ALSA lib /home/volumio-fifo-plugin/src/pcm_volumiofifo.c:753:(_snd_pcm_volumiofifo_open) Failed to open output fifo /tmp/fusiondspfifo
May 13 09:03:14 volumio mpd[3016]: alsa_output: Error opening default ALSA device: No such file or directory
May 13 09:03:14 volumio mpd[3016]: output: Successfully detected a jack audio device
May 13 09:03:14 volumio volumio[2793]: info: [1747101794755] ControllerPandora::validateAndSetAccountOptions
May 13 09:03:14 volumio mpd[3016]: zeroconf: No global port, disabling zeroconf
May 13 09:03:14 volumio systemd[1]: Started Music Player Daemon.
May 13 09:03:14 volumio volumio[2793]: error: [1747101794758] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings.
May 13 09:03:14 volumio sudo[2994]: pam_unix(sudo:session): session closed for user root
May 13 09:03:14 volumio sudo[3004]: pam_unix(sudo:session): session closed for user root
May 13 09:03:14 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::volumioRetrievevolume
May 13 09:03:14 volumio volumio[2793]: info: [now-playing] App is listening on port 4004.
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::volumioGetState
May 13 09:03:14 volumio volumio[2793]: info: CorePlayQueue::getTrack 0
May 13 09:03:14 volumio volumio[2793]: info: CoreStateMachine::pushState
May 13 09:03:14 volumio volumio[2793]: info: CorePlayQueue::getTrack 0
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::volumioPushState
May 13 09:03:14 volumio volumio[2793]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
May 13 09:03:14 volumio volumio[2793]: info: [squeezelite_mc] Server discovery started
May 13 09:03:14 volumio volumio[2793]: info: [squeezelite_mc] Player finder started
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:14 volumio volumio[2793]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:03:14 volumio volumio[2793]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true
May 13 09:03:14 volumio volumio[2793]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 09:03:15 volumio volumio[2793]: Error: send ENETUNREACH 255.255.255.255:3483
May 13 09:03:15 volumio volumio[2793]: at doSend (dgram.js:714:16)
May 13 09:03:15 volumio volumio[2793]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18)
May 13 09:03:15 volumio volumio[2793]: at afterDns (dgram.js:660:5)
May 13 09:03:15 volumio volumio[2793]: at processTicksAndRejections (internal/process/task_queues.js:83:21) {
May 13 09:03:15 volumio volumio[2793]: errno: -101,
May 13 09:03:15 volumio volumio[2793]: code: 'ENETUNREACH',
May 13 09:03:15 volumio volumio[2793]: syscall: 'send',
May 13 09:03:15 volumio volumio[2793]: address: '255.255.255.255',
May 13 09:03:15 volumio volumio[2793]: port: 3483
May 13 09:03:15 volumio volumio[2793]: }
May 13 09:03:15 volumio volumio[2793]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 09:03:15 volumio sudo[3060]: pam_unix(sudo:session): session closed for user root
May 13 09:03:15 volumio volumio[3093]: cset: --> shielding system active with
May 13 09:03:15 volumio volumio[3093]: cset: "system" cpuset of CPUSPEC(1-3) with 225 tasks running
May 13 09:03:15 volumio volumio[3093]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
May 13 09:03:15 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
May 13 09:03:15 volumio sudo[3123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 09:02
May 13 09:03:15 volumio sudo[3123]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:15 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:15 volumio sudo[3123]: pam_unix(sudo:session): session closed for user root
May 13 09:03:15 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:15 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:15 volumio volumio-remote-updater[817]: [2025-05-13 09:03:15] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
May 13 09:03:15 volumio volumio-remote-updater[817]: [2025-05-13 09:03:15] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
May 13 09:03:15 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
May 13 09:03:15 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
May 13 09:03:15 volumio systemd[1]: Started dynamicswap service.
May 13 09:03:15 volumio systemd[1]: dynamicswap.service: Succeeded.
May 13 09:03:16 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
May 13 09:03:16 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 215.
May 13 09:03:16 volumio systemd[1]: Started dynamicswap service.
May 13 09:03:16 volumio systemd[1]: Stopped Volumio Backend Module.
May 13 09:03:16 volumio systemd[1]: Started Volumio Backend Module.
May 13 09:03:16 volumio systemd[1]: dynamicswap.service: Succeeded.
May 13 09:03:17 volumio volumio[3142]: info: -------------------------------------------
May 13 09:03:17 volumio volumio[3142]: info: ----- Volumio3 ----
May 13 09:03:17 volumio volumio[3142]: info: -------------------------------------------
May 13 09:03:17 volumio volumio[3142]: info: ----- System startup ----
May 13 09:03:17 volumio volumio[3142]: info: -------------------------------------------
May 13 09:03:18 volumio volumio[3142]: info: MYVOLUMIO Environment detected
May 13 09:03:18 volumio volumio[3142]: info: Plugin folders cleanup
May 13 09:03:18 volumio volumio[3142]: info: Scanning into folder /volumio/app/plugins/
May 13 09:03:18 volumio volumio[3142]: info: Scanning category audio_interface
May 13 09:03:18 volumio volumio[3142]: info: Scanning category miscellanea
May 13 09:03:18 volumio volumio[3142]: info: Scanning category music_service
May 13 09:03:18 volumio volumio[3142]: info: Scanning category plugins.json
May 13 09:03:18 volumio volumio[3142]: info: Scanning category system_controller
May 13 09:03:18 volumio volumio[3142]: info: Scanning category user_interface
May 13 09:03:18 volumio volumio[3142]: info: Scanning into folder /data/plugins/
May 13 09:03:18 volumio volumio[3142]: info: Scanning category audio_interface
May 13 09:03:18 volumio volumio[3142]: info: Scanning category music_service
May 13 09:03:18 volumio volumio[3142]: info: Scanning category peppymeterbasic
May 13 09:03:18 volumio volumio[3142]: info: Scanning category system_controller
May 13 09:03:18 volumio volumio[3142]: info: Scanning category system_hardware
May 13 09:03:18 volumio volumio[3142]: info: Scanning category user_interface
May 13 09:03:18 volumio volumio[3142]: info: Plugin folders cleanup completed
May 13 09:03:18 volumio volumio[3142]: info: -------------------------------------------
May 13 09:03:18 volumio volumio[3142]: info: ----- Core plugins startup ----
May 13 09:03:18 volumio volumio[3142]: info: -------------------------------------------
May 13 09:03:18 volumio volumio[3142]: info: Loading plugins from folder /volumio/app/plugins/
May 13 09:03:18 volumio volumio[3142]: info: Adding plugin upnp to MyMusic Plugins
May 13 09:03:18 volumio volumio[3142]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 13 09:03:18 volumio volumio[3142]: info: Adding plugin upnp_browser to MyMusic Plugins
May 13 09:03:18 volumio volumio[3142]: info: Loading plugins from folder /data/plugins/
May 13 09:03:18 volumio volumio[3142]: info: Loading plugin "system"...
May 13 09:03:18 volumio volumio[3142]: info: Loading plugin "appearance"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "network"...
May 13 09:03:19 volumio volumio[3142]: info: Refreshing Cached IP Addresses
May 13 09:03:19 volumio sudo[3168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 13 09:03:19 volumio sudo[3168]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:19 volumio sudo[3168]: pam_unix(sudo:session): session closed for user root
May 13 09:03:19 volumio sudo[3170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 13 09:03:19 volumio sudo[3170]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:19 volumio sudo[3170]: pam_unix(sudo:session): session closed for user root
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "services"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "alsa_controller"...
May 13 09:03:19 volumio sudo[3182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 13 09:03:19 volumio sudo[3182]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:19 volumio sudo[3182]: pam_unix(sudo:session): session closed for user root
May 13 09:03:19 volumio volumio[3142]: warn: Unable to locate the audio output device BursonAudio USB Audio 2.0. Please configure a valid output device.
May 13 09:03:19 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "wizard"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "networkfs"...
May 13 09:03:19 volumio volumio[3142]: info: Starting Udev Watcher for removable devices
May 13 09:03:19 volumio volumio[3142]: info: Ignoring mount for partition: boot
May 13 09:03:19 volumio volumio[3142]: info: Ignoring mount for partition: volumio
May 13 09:03:19 volumio volumio[3142]: info: Ignoring mount for partition: volumio_data
May 13 09:03:19 volumio volumio[3142]: info: Ignoring mount for partition: boot
May 13 09:03:19 volumio volumio[3142]: info: Ignoring mount for partition: volumio
May 13 09:03:19 volumio volumio[3142]: info: Ignoring mount for partition: volumio_data
May 13 09:03:19 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "volumio_command_line_client"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "upnp"...
May 13 09:03:19 volumio volumio[3142]: info: [1747101799300] Starting Upmpd Daemon
May 13 09:03:19 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "my_music"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "mpd"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "upnp_browser"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "alarm-clock"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "airplay_emulation"...
May 13 09:03:19 volumio volumio[3142]: info: Starting Shairport Sync
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "last_100"...
May 13 09:03:19 volumio volumio[3142]: info: Loading plugin "webradio"...
May 13 09:03:20 volumio volumio[3142]: info: Loading plugin "i2s_dacs"...
May 13 09:03:20 volumio volumio[3142]: info: I2S DAC not set, start Auto-detection
May 13 09:03:20 volumio volumio[3142]: info: Loading plugin "volumiodiscovery"...
May 13 09:03:20 volumio volumio[3142]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 13 09:03:20 volumio volumio[3142]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:03:20 volumio volumio[3142]: *** WARNING *** For more information see
May 13 09:03:20 volumio node[3142]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 13 09:03:20 volumio volumio[3142]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 13 09:03:20 volumio volumio[3142]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:03:20 volumio volumio[3142]: *** WARNING *** For more information see
May 13 09:03:20 volumio node[3142]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:03:20 volumio node[3142]: *** WARNING *** For more information see
May 13 09:03:20 volumio node[3142]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 13 09:03:20 volumio node[3142]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:03:20 volumio node[3142]: *** WARNING *** For more information see
May 13 09:03:20 volumio volumio[3142]: info: Applying required configuration parameters for plugin volumiodiscovery
May 13 09:03:20 volumio volumio[3142]: info: Discovery: Started advertising with name: Volumio
May 13 09:03:20 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:03:20 volumio volumio[3142]: info: Loading plugin "jellyfin"...
May 13 09:03:20 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:20 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:20 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:20 volumio volumio[3142]: info: Loading plugin "soundcloud"...
May 13 09:03:20 volumio volumio-remote-updater[817]: [2025-05-13 09:03:20] [connect] Successful connection
May 13 09:03:21 volumio volumio[3142]: info: Loading plugin "spop"...
May 13 09:03:21 volumio volumio[3142]: info: Loading plugin "squeezelite_mc"...
May 13 09:03:22 volumio volumio[3142]: info: Loading plugin "youtube2"...
May 13 09:03:23 volumio ntpd[941]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
May 13 09:03:24 volumio volumio[3142]: info: Loading plugin "ytcr"...
May 13 09:03:25 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:25 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:25 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:28 volumio volumio[3142]: info: Loading plugin "ytmusic"...
May 13 09:03:30 volumio volumio[3142]: info: Loading plugin "autostart"...
May 13 09:03:30 volumio volumio[3142]: info: Applying required configuration parameters for plugin autostart
May 13 09:03:30 volumio volumio[3142]: info: AutoStart - onVolumioStart - read config.json
May 13 09:03:30 volumio volumio[3142]: info: Loading plugin "now_playing"...
May 13 09:03:30 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:30 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:30 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:31 volumio volumio[3142]: info: Loading plugin "outputs"...
May 13 09:03:31 volumio volumio[3142]: info: Loading plugin "albumart"...
May 13 09:03:31 volumio volumio[3142]: info: Plugin example_plugin is not enabled
May 13 09:03:31 volumio volumio[3142]: info: Loading plugin "inputs"...
May 13 09:03:31 volumio volumio[3142]: info: Loading plugin "updater_comm"...
May 13 09:03:31 volumio volumio[3142]: info: Plugin mpdemulation is not enabled
May 13 09:03:31 volumio volumio[3142]: info: Loading plugin "rest_api"...
May 13 09:03:31 volumio volumio[3142]: Forking 3 albumart workers
May 13 09:03:31 volumio volumio[3142]: info: Loading plugin "websocket"...
May 13 09:03:31 volumio volumio[3142]: info: Starting Socket.io Server version 2.3.0
May 13 09:03:31 volumio volumio[3142]: info: Loading plugin "fusiondsp"...
May 13 09:03:31 volumio volumio[3142]: info: Applying required configuration parameters for plugin fusiondsp
May 13 09:03:32 volumio volumio[3142]: info: Loading plugin "mpdoutput"...
May 13 09:03:32 volumio volumio[3142]: info: Loading plugin "RoonBridge"...
May 13 09:03:32 volumio volumio[3142]: info: Applying required configuration parameters for plugin RoonBridge
May 13 09:03:32 volumio volumio[3142]: info: Loading plugin "minidlna"...
May 13 09:03:32 volumio volumio[3142]: Starting albumart workers
May 13 09:03:32 volumio volumio[3142]: info: Applying required configuration parameters for plugin minidlna
May 13 09:03:32 volumio volumio[3142]: info: Loading plugin "myb"...
May 13 09:03:33 volumio volumio[3142]: Starting albumart workers
May 13 09:03:33 volumio volumio[3142]: Starting albumart workers
May 13 09:03:33 volumio volumio[3142]: info: Applying required configuration parameters for plugin myb
May 13 09:03:33 volumio volumio[3142]: info: Loading plugin "pandora"...
May 13 09:03:33 volumio volumio-remote-updater[817]: [2025-05-13 09:03:33] [connect] Successful connection
May 13 09:03:33 volumio ntpd[941]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
May 13 09:03:34 volumio volumio[3142]: info: Applying required configuration parameters for plugin pandora
May 13 09:03:34 volumio volumio[3142]: info: Loading plugin "podcast"...
May 13 09:03:34 volumio volumio[3142]: info: ControllerPodcast::constructor
May 13 09:03:34 volumio volumio[3142]: info: Loading plugin "swarmstation"...
May 13 09:03:34 volumio volumio[3142]: info: Applying required configuration parameters for plugin swarmstation
May 13 09:03:34 volumio volumio[3142]: info: [1747101814682] [Swarmstation] API delay: 5
May 13 09:03:34 volumio volumio[3142]: info: Loading plugin "volusonic"...
May 13 09:03:35 volumio volumio[3142]: info: Applying required configuration parameters for plugin volusonic
May 13 09:03:35 volumio volumio[3142]: info: Plugin peppymeterbasic is not enabled
May 13 09:03:35 volumio volumio[3142]: info: Loading plugin "backup_restore"...
May 13 09:03:35 volumio volumio[3142]: info: Applying required configuration parameters for plugin backup_restore
May 13 09:03:35 volumio volumio[3142]: info: Loading plugin "music_services_shield"...
May 13 09:03:35 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:35 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:35 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:35 volumio volumio[3142]: info: Applying required configuration parameters for plugin music_services_shield
May 13 09:03:35 volumio volumio[3142]: info: Loading plugin "Systeminfo"...
May 13 09:03:36 volumio volumio[3142]: info: Loading plugin "peppyspectrum"...
May 13 09:03:36 volumio volumio[3142]: info: Loading plugin "randomizer"...
May 13 09:03:36 volumio volumio[3142]: info: Applying required configuration parameters for plugin randomizer
May 13 09:03:36 volumio volumio[3142]: info: Loading i18n strings for locale vi
May 13 09:03:36 volumio volumio[3142]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:03:36 volumio volumio[3142]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:03:36 volumio volumio[3142]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:03:36 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:03:36 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:03:36 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:03:36 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:03:36 volumio volumio[3142]: Updating browse sources language
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::initPlayerControls
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:03:36 volumio volumio[3142]: Express server listening on port 3000
May 13 09:03:36 volumio volumio[3142]: [Metrics] WebUI: 19s 761.61ms
May 13 09:03:36 volumio volumio[3142]: info: Setting Device type: x86
May 13 09:03:36 volumio volumio[3142]: info: CoreStateMachine::resetVolumioState
May 13 09:03:36 volumio volumio[3142]: info: CoreStateMachine::getcurrentVolume
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::volumioRetrievevolume
May 13 09:03:36 volumio volumio[3142]: info: CoreStateMachine::pushState
May 13 09:03:36 volumio volumio[3142]: info: CorePlayQueue::getTrack 0
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::volumioPushState
May 13 09:03:36 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:36 volumio sudo[3285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 13 09:03:36 volumio sudo[3285]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:36 volumio sudo[3285]: pam_unix(sudo:session): session closed for user root
May 13 09:03:36 volumio volumio[3142]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
May 13 09:03:36 volumio volumio[3142]: info: Completed loading Core Plugins
May 13 09:03:36 volumio sudo[3288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 13 09:03:36 volumio sudo[3288]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:36 volumio volumio[3142]: info: Preparing to generate the ALSA configuration file
May 13 09:03:36 volumio sudo[3288]: pam_unix(sudo:session): session closed for user root
May 13 09:03:37 volumio volumio[3142]: info: Volumio Network Manager: Network status updated: 0
May 13 09:03:37 volumio volumio[3142]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
May 13 09:03:37 volumio volumio[3142]: wlan0 Interface doesn't support scanning : Device or resource busy
May 13 09:03:37 volumio volumio[3142]: info: Cannot use regular scanning, forcing with ap-force
May 13 09:03:37 volumio sudo[3291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
May 13 09:03:37 volumio sudo[3291]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:40 volumio sudo[3291]: pam_unix(sudo:session): session closed for user root
May 13 09:03:40 volumio volumio[3142]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
May 13 09:03:40 volumio volumio[3142]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 13 09:03:40 volumio volumio[3142]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
May 13 09:03:40 volumio volumio[3142]: info: Reading ALSA contributions from plugins.
May 13 09:03:40 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:40 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:40 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:40 volumio volumio[3142]: info: Cannot read play queue from file
May 13 09:03:40 volumio volumio[3142]: info: CoreStateMachine::setRepeat true single undefined
May 13 09:03:40 volumio volumio[3142]: info: CoreStateMachine::pushState
May 13 09:03:40 volumio volumio[3142]: info: CorePlayQueue::getTrack 0
May 13 09:03:40 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:03:40 volumio volumio[3142]: info: CoreCommandRouter::volumioPushState
May 13 09:03:40 volumio volumio[3142]: info: CoreStateMachine::setRandom true
May 13 09:03:40 volumio volumio[3142]: info: CoreStateMachine::pushState
May 13 09:03:40 volumio volumio[3142]: info: CorePlayQueue::getTrack 0
May 13 09:03:40 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:03:40 volumio volumio[3142]: info: CoreCommandRouter::volumioPushState
May 13 09:03:40 volumio volumio[3142]: info: Asound.conf file unchanged, so no further update is needed
May 13 09:03:40 volumio volumio[3142]: info: Output device has changed, restarting MPD
May 13 09:03:40 volumio sudo[3317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 13 09:03:40 volumio sudo[3317]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:40 volumio sudo[3317]: pam_unix(sudo:session): session closed for user root
May 13 09:03:41 volumio sudo[3320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 09:03:41 volumio sudo[3320]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:41 volumio sudo[3320]: pam_unix(sudo:session): session closed for user root
May 13 09:03:41 volumio volumio[3142]: info: Output device has changed, restarting Shairport Sync
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:41 volumio sudo[3323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 09:03:41 volumio sudo[3323]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:41 volumio systemd[1]: musicservicesshield.service: Succeeded.
May 13 09:03:41 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
May 13 09:03:41 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
May 13 09:03:41 volumio systemd[1]: Stopping Music Player Daemon...
May 13 09:03:41 volumio systemd[1]: mpd.service: Succeeded.
May 13 09:03:41 volumio systemd[1]: Stopped Music Player Daemon.
May 13 09:03:41 volumio volumio[3142]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:03:41 volumio volumio[3142]: info: ___________ START PLUGINS ___________
May 13 09:03:41 volumio volumio[3142]: info: ControllerMpd::onStart: Initializing MPD
May 13 09:03:41 volumio volumio[3142]: info: Creating MPD Configuration file
May 13 09:03:41 volumio systemd[1]: Starting Music Player Daemon...
May 13 09:03:41 volumio sudo[3331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 09:03:41 volumio sudo[3331]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:41 volumio sudo[3331]: pam_unix(sudo:session): session closed for user root
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821238] CoreMusicLibrary::Adding element Máy chủ Media
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio sudo[3334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 09:03:41 volumio sudo[3334]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:41 volumio sudo[3329]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 13 09:03:41 volumio sudo[3329]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:41 volumio sudo[3329]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 13 09:03:41 volumio sudo[3329]: pam_unix(sudo:session): session closed for user root
May 13 09:03:41 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 13 09:03:41 volumio systemd[1]: mpd.service: Succeeded.
May 13 09:03:41 volumio systemd[1]: Stopped Music Player Daemon.
May 13 09:03:41 volumio systemd[1]: Starting Music Player Daemon...
May 13 09:03:41 volumio volumio[3142]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:41 volumio volumio[3142]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821427] CoreMusicLibrary::Adding element Last_100
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821431] CoreMusicLibrary::Adding element Webradio
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:03:41 volumio sudo[3341]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 13 09:03:41 volumio sudo[3341]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:41 volumio volumio[3142]: info: Initializing BBC Radios
May 13 09:03:41 volumio sudo[3341]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 13 09:03:41 volumio sudo[3341]: pam_unix(sudo:session): session closed for user root
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 13 09:03:41 volumio volumio[3142]: info: Discovery: Getting this device information
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioGetState
May 13 09:03:41 volumio volumio[3142]: info: CorePlayQueue::getTrack 0
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821617] CoreMusicLibrary::Adding element Jellyfin
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:41 volumio volumio[3142]: info: [jellyfin] Initialized plugin with device info: {"id":"88b6c06e-9c07-4af1-b4f1-01959a64deb2","host":"http://127.0.0.1","name":"Volumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":100,"mute":false,"artist":"","track":"","albumart":"http://127.0.0.1/albumart"}}
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821629] CoreMusicLibrary::Adding element SoundCloud
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:41 volumio volumio[3142]: info: Creating Spotify config file
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:41 volumio volumio[3142]: info: [squeezelite_mc] Starting proxy server...
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821762] CoreMusicLibrary::Adding element YouTube2
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821810] CoreMusicLibrary::Adding element YouTube Music
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source YouTube Music
May 13 09:03:41 volumio volumio[3142]: info: AutoStart - onStart
May 13 09:03:41 volumio volumio[3142]: info: [now-playing] ConfigUpdater: config is up to date.
May 13 09:03:41 volumio volumio[3142]: info: Loading i18n strings for locale vi
May 13 09:03:41 volumio volumio[3142]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:03:41 volumio volumio[3142]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:03:41 volumio volumio[3142]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:41 volumio volumio[3142]: info: FusionDsp - mixtype--------------------- None
May 13 09:03:41 volumio volumio[3142]: info: Loading i18n strings for locale vi
May 13 09:03:41 volumio volumio[3142]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:03:41 volumio volumio[3142]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:03:41 volumio volumio[3142]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:03:41 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:03:41 volumio sudo[3358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
May 13 09:03:41 volumio sudo[3358]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:41 volumio sudo[3358]: pam_unix(sudo:session): session closed for user root
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821983] CoreMusicLibrary::Adding element Pandora Radio
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source YouTube Music
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source Pandora Radio
May 13 09:03:41 volumio volumio[3142]: info: [1747101821989] ControllerPandora::initializeMQTT
May 13 09:03:41 volumio volumio[3142]: info: [1747101821990] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:41 volumio volumio[3142]: info: [1747101821998] CoreMusicLibrary::Adding element Podcast
May 13 09:03:41 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:41 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube Music
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Pandora Radio
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Podcast
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:42 volumio volumio[3142]: info: [1747101822006] CoreMusicLibrary::Adding element SWARM Station
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube Music
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Pandora Radio
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Podcast
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SWARM Station
May 13 09:03:42 volumio volumio[3142]: info: Loading i18n strings for locale vi
May 13 09:03:42 volumio volumio[3142]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:03:42 volumio volumio[3142]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:03:42 volumio volumio[3142]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:03:42 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:03:42 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:03:42 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:03:42 volumio volumio[3142]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:03:42 volumio volumio[3142]: Updating browse sources language
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube Music
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Pandora Radio
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Podcast
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SWARM Station
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube Music
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Pandora Radio
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Podcast
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SWARM Station
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:42 volumio volumio[3142]: info: [1747101822063] CoreMusicLibrary::Adding element Volusonic
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube Music
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Pandora Radio
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Podcast
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SWARM Station
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Volusonic
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 13 09:03:42 volumio sudo[3388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
May 13 09:03:42 volumio sudo[3388]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:03:42 volumio volumio[3142]: info: [1747101822554] CoreMusicLibrary::Adding element Randomizer
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Jellyfin
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SoundCloud
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube2
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source YouTube Music
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Pandora Radio
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Podcast
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source SWARM Station
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Volusonic
May 13 09:03:42 volumio volumio[3142]: Cannot find translation for source Randomizer
May 13 09:03:42 volumio volumio[3142]: info: Volumio Calling Home
May 13 09:03:42 volumio volumio[3142]: info: [squeezelite_mc] Proxy server started on port 42023
May 13 09:03:42 volumio volumio[3142]: info: Preparing to generate the ALSA configuration file
May 13 09:03:42 volumio volumio[3142]: info: [1747101822717] ControllerPandora::initialSetup
May 13 09:03:42 volumio volumio[3142]: info: [1747101822721] ControllerPandora::PandoraHandler::init
May 13 09:03:42 volumio volumio[3142]: info: [1747101822722] ControllerPandora::PandoraHandler::loadErrorCodes
May 13 09:03:42 volumio volumio[3142]: info: [1747101822738] [Pandora] PandoraHandler::setMaxStationTracks: 16
May 13 09:03:42 volumio volumio[3142]: info: [1747101822740] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty
May 13 09:03:42 volumio volumio[3142]: info: [1747101822741] ControllerPandora::flushPandora
May 13 09:03:42 volumio volumio[3142]: info: CorePlayQueue::getQueue
May 13 09:03:42 volumio volumio[3142]: info: CorePlayQueue::clearPlayQueue
May 13 09:03:42 volumio volumio[3142]: info: CorePlayQueue::saveQueue
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::volumioPushQueue
May 13 09:03:42 volumio volumio[3142]: info: [1747101822749] ControllerPandora::validateAndSetAccountOptions
May 13 09:03:42 volumio volumio[3142]: error: [1747101822750] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings.
May 13 09:03:42 volumio mpd[3346]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 13 09:03:42 volumio mpd[3346]: output: No 'audio_output' defined in config file
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::volumioRetrievevolume
May 13 09:03:42 volumio mpd[3346]: couldn't open play stream: No such file or directory
May 13 09:03:42 volumio mpd[3346]: sndio_output: Error opening default sndio device
May 13 09:03:42 volumio volumio[3142]: info: [now-playing] App is listening on port 4004.
May 13 09:03:42 volumio mpd[3346]: ALSA lib /home/volumio-fifo-plugin/src/pcm_volumiofifo.c:753:(_snd_pcm_volumiofifo_open) Failed to open output fifo /tmp/fusiondspfifo
May 13 09:03:42 volumio mpd[3346]: alsa_output: Error opening default ALSA device: No such file or directory
May 13 09:03:42 volumio mpd[3346]: output: Successfully detected a jack audio device
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::volumioGetState
May 13 09:03:42 volumio mpd[3346]: zeroconf: No global port, disabling zeroconf
May 13 09:03:42 volumio systemd[1]: Started Music Player Daemon.
May 13 09:03:42 volumio volumio[3142]: info: CorePlayQueue::getTrack 0
May 13 09:03:42 volumio volumio[3142]: info: CoreStateMachine::pushState
May 13 09:03:42 volumio volumio[3142]: info: CorePlayQueue::getTrack 0
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::volumioPushState
May 13 09:03:42 volumio sudo[3323]: pam_unix(sudo:session): session closed for user root
May 13 09:03:42 volumio sudo[3334]: pam_unix(sudo:session): session closed for user root
May 13 09:03:42 volumio volumio[3142]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
May 13 09:03:42 volumio volumio[3142]: info: [squeezelite_mc] Server discovery started
May 13 09:03:42 volumio volumio[3142]: info: [squeezelite_mc] Player finder started
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:03:42 volumio volumio[3142]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:03:42 volumio volumio[3142]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true
May 13 09:03:42 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
May 13 09:03:42 volumio volumio[3142]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 09:03:42 volumio volumio[3142]: Error: send ENETUNREACH 255.255.255.255:3483
May 13 09:03:42 volumio volumio[3142]: at doSend (dgram.js:714:16)
May 13 09:03:42 volumio volumio[3142]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18)
May 13 09:03:42 volumio volumio[3142]: at afterDns (dgram.js:660:5)
May 13 09:03:42 volumio volumio[3142]: at processTicksAndRejections (internal/process/task_queues.js:83:21) {
May 13 09:03:42 volumio volumio[3142]: errno: -101,
May 13 09:03:42 volumio volumio[3142]: code: 'ENETUNREACH',
May 13 09:03:42 volumio volumio[3142]: syscall: 'send',
May 13 09:03:42 volumio volumio[3142]: address: '255.255.255.255',
May 13 09:03:42 volumio volumio[3142]: port: 3483
May 13 09:03:42 volumio volumio[3142]: }
May 13 09:03:42 volumio volumio[3142]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 09:03:43 volumio sudo[3388]: pam_unix(sudo:session): session closed for user root
May 13 09:03:43 volumio sudo[3436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 09:02
May 13 09:03:43 volumio sudo[3436]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:43 volumio volumio[3407]: cset: --> shielding system active with
May 13 09:03:43 volumio volumio[3407]: cset: "system" cpuset of CPUSPEC(1-3) with 226 tasks running
May 13 09:03:43 volumio volumio[3407]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
May 13 09:03:43 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
May 13 09:03:43 volumio sudo[3436]: pam_unix(sudo:session): session closed for user root
May 13 09:03:43 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
May 13 09:03:43 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
May 13 09:03:43 volumio ntpd[941]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
May 13 09:03:43 volumio systemd[1]: Started dynamicswap service.
May 13 09:03:43 volumio systemd[1]: dynamicswap.service: Succeeded.
May 13 09:03:43 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
May 13 09:03:43 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 216.
May 13 09:03:43 volumio systemd[1]: Started dynamicswap service.
May 13 09:03:43 volumio systemd[1]: Stopped Volumio Backend Module.
May 13 09:03:43 volumio systemd[1]: Started Volumio Backend Module.
May 13 09:03:44 volumio systemd[1]: dynamicswap.service: Succeeded.
May 13 09:03:45 volumio volumio[3450]: info: -------------------------------------------
May 13 09:03:45 volumio volumio[3450]: info: ----- Volumio3 ----
May 13 09:03:45 volumio volumio[3450]: info: -------------------------------------------
May 13 09:03:45 volumio volumio[3450]: info: ----- System startup ----
May 13 09:03:45 volumio volumio[3450]: info: -------------------------------------------
May 13 09:03:45 volumio volumio[3450]: info: MYVOLUMIO Environment detected
May 13 09:03:45 volumio volumio[3450]: info: Plugin folders cleanup
May 13 09:03:45 volumio volumio[3450]: info: Scanning into folder /volumio/app/plugins/
May 13 09:03:45 volumio ntpd[941]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
May 13 09:03:45 volumio volumio[3450]: info: Scanning category audio_interface
May 13 09:03:45 volumio volumio[3450]: info: Scanning category miscellanea
May 13 09:03:45 volumio volumio[3450]: info: Scanning category music_service
May 13 09:03:45 volumio volumio[3450]: info: Scanning category plugins.json
May 13 09:03:45 volumio volumio[3450]: info: Scanning category system_controller
May 13 09:03:45 volumio volumio[3450]: info: Scanning category user_interface
May 13 09:03:45 volumio volumio[3450]: info: Scanning into folder /data/plugins/
May 13 09:03:45 volumio volumio[3450]: info: Scanning category audio_interface
May 13 09:03:45 volumio volumio[3450]: info: Scanning category music_service
May 13 09:03:45 volumio volumio[3450]: info: Scanning category peppymeterbasic
May 13 09:03:45 volumio volumio[3450]: info: Scanning category system_controller
May 13 09:03:45 volumio volumio[3450]: info: Scanning category system_hardware
May 13 09:03:45 volumio volumio[3450]: info: Scanning category user_interface
May 13 09:03:45 volumio volumio[3450]: info: Plugin folders cleanup completed
May 13 09:03:45 volumio volumio[3450]: info: -------------------------------------------
May 13 09:03:45 volumio volumio[3450]: info: ----- Core plugins startup ----
May 13 09:03:45 volumio volumio[3450]: info: -------------------------------------------
May 13 09:03:45 volumio volumio[3450]: info: Loading plugins from folder /volumio/app/plugins/
May 13 09:03:45 volumio volumio[3450]: info: Adding plugin upnp to MyMusic Plugins
May 13 09:03:45 volumio volumio[3450]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 13 09:03:45 volumio volumio[3450]: info: Adding plugin upnp_browser to MyMusic Plugins
May 13 09:03:45 volumio volumio[3450]: info: Loading plugins from folder /data/plugins/
May 13 09:03:45 volumio volumio[3450]: info: Loading plugin "system"...
May 13 09:03:45 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:45 volumio volumio[3450]: info: Loading plugin "appearance"...
May 13 09:03:45 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:45 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "network"...
May 13 09:03:46 volumio volumio[3450]: info: Refreshing Cached IP Addresses
May 13 09:03:46 volumio sudo[3481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 13 09:03:46 volumio sudo[3481]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:46 volumio sudo[3481]: pam_unix(sudo:session): session closed for user root
May 13 09:03:46 volumio sudo[3483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 13 09:03:46 volumio sudo[3483]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:46 volumio sudo[3483]: pam_unix(sudo:session): session closed for user root
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "services"...
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "alsa_controller"...
May 13 09:03:46 volumio sudo[3496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 13 09:03:46 volumio sudo[3496]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:03:46 volumio volumio[3450]: warn: Unable to locate the audio output device BursonAudio USB Audio 2.0. Please configure a valid output device.
May 13 09:03:46 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "wizard"...
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "networkfs"...
May 13 09:03:46 volumio volumio[3450]: info: Starting Udev Watcher for removable devices
May 13 09:03:46 volumio volumio[3450]: info: Ignoring mount for partition: boot
May 13 09:03:46 volumio volumio[3450]: info: Ignoring mount for partition: volumio
May 13 09:03:46 volumio volumio[3450]: info: Ignoring mount for partition: volumio_data
May 13 09:03:46 volumio volumio[3450]: info: Ignoring mount for partition: boot
May 13 09:03:46 volumio volumio[3450]: info: Ignoring mount for partition: volumio
May 13 09:03:46 volumio volumio[3450]: info: Ignoring mount for partition: volumio_data
May 13 09:03:46 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "volumio_command_line_client"...
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "upnp"...
May 13 09:03:46 volumio volumio[3450]: info: [1747101826867] Starting Upmpd Daemon
May 13 09:03:46 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "my_music"...
May 13 09:03:46 volumio volumio[3450]: info: Loading plugin "mpd"...
May 13 09:03:47 volumio volumio[3450]: info: Loading plugin "upnp_browser"...
May 13 09:03:47 volumio volumio[3450]: info: Loading plugin "alarm-clock"...
May 13 09:03:47 volumio volumio[3450]: info: Loading plugin "airplay_emulation"...
May 13 09:03:47 volumio volumio[3450]: info: Starting Shairport Sync
May 13 09:03:47 volumio volumio[3450]: info: Loading plugin "last_100"...
May 13 09:03:47 volumio volumio[3450]: info: Loading plugin "webradio"...
May 13 09:03:47 volumio volumio[3450]: info: Loading plugin "i2s_dacs"...
May 13 09:03:47 volumio volumio[3450]: info: I2S DAC not set, start Auto-detection
May 13 09:03:47 volumio volumio[3450]: info: Loading plugin "volumiodiscovery"...
May 13 09:03:47 volumio volumio[3450]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 13 09:03:47 volumio volumio[3450]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:03:47 volumio volumio[3450]: *** WARNING *** For more information see
May 13 09:03:47 volumio node[3450]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 13 09:03:47 volumio volumio[3450]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 13 09:03:47 volumio volumio[3450]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:03:47 volumio volumio[3450]: *** WARNING *** For more information see
May 13 09:03:47 volumio node[3450]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:03:47 volumio node[3450]: *** WARNING *** For more information see
May 13 09:03:47 volumio node[3450]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 13 09:03:47 volumio node[3450]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:03:47 volumio node[3450]: *** WARNING *** For more information see
May 13 09:03:47 volumio volumio[3450]: info: Applying required configuration parameters for plugin volumiodiscovery
May 13 09:03:47 volumio volumio[3450]: info: Discovery: Started advertising with name: Volumio
May 13 09:03:47 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:03:47 volumio volumio[3450]: info: Loading plugin "jellyfin"...
May 13 09:03:48 volumio volumio[3450]: info: Loading plugin "soundcloud"...
May 13 09:03:48 volumio volumio-remote-updater[817]: [2025-05-13 09:03:48] [connect] Successful connection
May 13 09:03:48 volumio volumio[3450]: info: Loading plugin "spop"...
May 13 09:03:49 volumio volumio[3450]: info: Loading plugin "squeezelite_mc"...
May 13 09:03:49 volumio volumio[3450]: info: Loading plugin "youtube2"...
May 13 09:03:50 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:50 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:50 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:52 volumio volumio[3450]: info: Loading plugin "ytcr"...
May 13 09:03:53 volumio sudo[3496]: pam_unix(sudo:session): session closed for user root
May 13 09:03:55 volumio volumio[3450]: info: Loading plugin "ytmusic"...
May 13 09:03:55 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:03:55 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:03:55 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:03:57 volumio volumio[3450]: info: Loading plugin "autostart"...
May 13 09:03:57 volumio volumio[3450]: info: Applying required configuration parameters for plugin autostart
May 13 09:03:57 volumio volumio[3450]: info: AutoStart - onVolumioStart - read config.json
May 13 09:03:57 volumio volumio[3450]: info: Loading plugin "now_playing"...
May 13 09:03:58 volumio volumio[3450]: info: Loading plugin "outputs"...
May 13 09:03:58 volumio volumio[3450]: info: Loading plugin "albumart"...
May 13 09:03:58 volumio volumio[3450]: info: Plugin example_plugin is not enabled
May 13 09:03:58 volumio volumio[3450]: info: Loading plugin "inputs"...
May 13 09:03:58 volumio volumio[3450]: info: Loading plugin "updater_comm"...
May 13 09:03:58 volumio volumio[3450]: info: Plugin mpdemulation is not enabled
May 13 09:03:58 volumio volumio[3450]: info: Loading plugin "rest_api"...
May 13 09:03:58 volumio volumio[3450]: info: Loading plugin "websocket"...
May 13 09:03:58 volumio volumio[3450]: info: Starting Socket.io Server version 2.3.0
May 13 09:03:58 volumio volumio[3450]: info: Loading plugin "fusiondsp"...
May 13 09:03:58 volumio volumio[3450]: Forking 3 albumart workers
May 13 09:03:59 volumio volumio[3450]: info: Applying required configuration parameters for plugin fusiondsp
May 13 09:03:59 volumio volumio[3450]: info: Loading plugin "mpdoutput"...
May 13 09:03:59 volumio volumio[3450]: info: Loading plugin "RoonBridge"...
May 13 09:03:59 volumio volumio[3450]: info: Applying required configuration parameters for plugin RoonBridge
May 13 09:03:59 volumio volumio[3450]: info: Loading plugin "minidlna"...
May 13 09:03:59 volumio volumio[3450]: info: Applying required configuration parameters for plugin minidlna
May 13 09:03:59 volumio volumio[3450]: Starting albumart workers
May 13 09:03:59 volumio volumio[3450]: info: Loading plugin "myb"...
May 13 09:03:59 volumio volumio[3450]: Starting albumart workers
May 13 09:04:00 volumio volumio[3450]: Starting albumart workers
May 13 09:04:00 volumio volumio[3450]: info: Applying required configuration parameters for plugin myb
May 13 09:04:00 volumio volumio[3450]: info: Loading plugin "pandora"...
May 13 09:04:00 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:04:01 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:04:01 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:04:01 volumio volumio[3450]: info: Applying required configuration parameters for plugin pandora
May 13 09:04:01 volumio volumio[3450]: info: Loading plugin "podcast"...
May 13 09:04:01 volumio volumio[3450]: info: ControllerPodcast::constructor
May 13 09:04:01 volumio volumio[3450]: info: Loading plugin "swarmstation"...
May 13 09:04:01 volumio volumio[3450]: info: Applying required configuration parameters for plugin swarmstation
May 13 09:04:01 volumio volumio[3450]: info: [1747101841866] [Swarmstation] API delay: 5
May 13 09:04:01 volumio volumio[3450]: info: Loading plugin "volusonic"...
May 13 09:04:02 volumio volumio[3450]: info: Applying required configuration parameters for plugin volusonic
May 13 09:04:02 volumio volumio[3450]: info: Plugin peppymeterbasic is not enabled
May 13 09:04:02 volumio volumio[3450]: info: Loading plugin "backup_restore"...
May 13 09:04:02 volumio volumio[3450]: info: Applying required configuration parameters for plugin backup_restore
May 13 09:04:02 volumio volumio[3450]: info: Loading plugin "music_services_shield"...
May 13 09:04:03 volumio volumio[3450]: info: Applying required configuration parameters for plugin music_services_shield
May 13 09:04:03 volumio volumio[3450]: info: Loading plugin "Systeminfo"...
May 13 09:04:03 volumio volumio[3450]: info: Loading plugin "peppyspectrum"...
May 13 09:04:03 volumio volumio-remote-updater[817]: [2025-05-13 09:04:03] [connect] Successful connection
May 13 09:04:03 volumio volumio[3450]: info: Loading plugin "randomizer"...
May 13 09:04:03 volumio volumio[3450]: info: Applying required configuration parameters for plugin randomizer
May 13 09:04:03 volumio volumio[3450]: info: Loading i18n strings for locale vi
May 13 09:04:03 volumio volumio[3450]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:04:03 volumio volumio[3450]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:04:03 volumio volumio[3450]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:04:03 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:04:03 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:04:03 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:04:03 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:04:03 volumio volumio[3450]: Updating browse sources language
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::initPlayerControls
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:04:03 volumio volumio[3450]: Express server listening on port 3000
May 13 09:04:03 volumio volumio[3450]: [Metrics] WebUI: 19s 71.89ms
May 13 09:04:03 volumio volumio[3450]: info: Setting Device type: x86
May 13 09:04:03 volumio volumio[3450]: info: CoreStateMachine::resetVolumioState
May 13 09:04:03 volumio volumio[3450]: info: CoreStateMachine::getcurrentVolume
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::volumioRetrievevolume
May 13 09:04:03 volumio volumio[3450]: info: CoreStateMachine::pushState
May 13 09:04:03 volumio volumio[3450]: info: CorePlayQueue::getTrack 0
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::volumioPushState
May 13 09:04:03 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:03 volumio sudo[3634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 13 09:04:03 volumio sudo[3634]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:03 volumio sudo[3634]: pam_unix(sudo:session): session closed for user root
May 13 09:04:03 volumio volumio[3450]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
May 13 09:04:03 volumio volumio[3450]: info: Completed loading Core Plugins
May 13 09:04:03 volumio sudo[3637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 13 09:04:03 volumio sudo[3637]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:03 volumio volumio[3450]: info: Preparing to generate the ALSA configuration file
May 13 09:04:03 volumio sudo[3637]: pam_unix(sudo:session): session closed for user root
May 13 09:04:04 volumio volumio[3450]: info: Volumio Network Manager: Network status updated: 0
May 13 09:04:04 volumio volumio[3450]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
May 13 09:04:04 volumio volumio[3450]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 13 09:04:04 volumio volumio[3450]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
May 13 09:04:04 volumio volumio[3450]: info: Reading ALSA contributions from plugins.
May 13 09:04:04 volumio volumio-remote-updater[817]: [2025-05-13 09:04:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747101843 101
May 13 09:04:04 volumio volumio[3450]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1
May 13 09:04:04 volumio volumio[3450]: info: Cannot read play queue from file
May 13 09:04:04 volumio volumio[3450]: info: CoreStateMachine::setRepeat true single undefined
May 13 09:04:04 volumio volumio[3450]: info: CoreStateMachine::pushState
May 13 09:04:04 volumio volumio[3450]: info: CorePlayQueue::getTrack 0
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::volumioPushState
May 13 09:04:04 volumio volumio[3450]: info: CoreStateMachine::setRandom true
May 13 09:04:04 volumio volumio[3450]: info: CoreStateMachine::pushState
May 13 09:04:04 volumio volumio[3450]: info: CorePlayQueue::getTrack 0
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::volumioPushState
May 13 09:04:04 volumio volumio[3450]: info: Asound.conf file unchanged, so no further update is needed
May 13 09:04:04 volumio volumio[3450]: info: Output device has changed, restarting MPD
May 13 09:04:04 volumio sudo[3644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 13 09:04:04 volumio sudo[3644]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:04 volumio sudo[3644]: pam_unix(sudo:session): session closed for user root
May 13 09:04:04 volumio sudo[3647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 09:04:04 volumio sudo[3647]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:04 volumio sudo[3647]: pam_unix(sudo:session): session closed for user root
May 13 09:04:04 volumio volumio[3450]: info: Output device has changed, restarting Shairport Sync
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:04 volumio sudo[3650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 09:04:04 volumio sudo[3650]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:04 volumio systemd[1]: musicservicesshield.service: Succeeded.
May 13 09:04:04 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
May 13 09:04:04 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
May 13 09:04:04 volumio systemd[1]: Stopping Music Player Daemon...
May 13 09:04:04 volumio systemd[1]: mpd.service: Succeeded.
May 13 09:04:04 volumio systemd[1]: Stopped Music Player Daemon.
May 13 09:04:04 volumio volumio[3450]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:04:04 volumio volumio[3450]: info: ___________ START PLUGINS ___________
May 13 09:04:04 volumio volumio[3450]: info: ControllerMpd::onStart: Initializing MPD
May 13 09:04:04 volumio volumio[3450]: info: Creating MPD Configuration file
May 13 09:04:04 volumio systemd[1]: Starting Music Player Daemon...
May 13 09:04:04 volumio sudo[3657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 09:04:04 volumio sudo[3657]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:04 volumio sudo[3657]: pam_unix(sudo:session): session closed for user root
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:04 volumio volumio[3450]: info: [1747101844588] CoreMusicLibrary::Adding element Máy chủ Media
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:04 volumio sudo[3660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 09:04:04 volumio sudo[3660]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:04 volumio sudo[3655]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 13 09:04:04 volumio sudo[3655]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:04 volumio sudo[3655]: pam_unix(sudo:session): session closed for user root
May 13 09:04:04 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
May 13 09:04:04 volumio systemd[1]: mpd.service: Succeeded.
May 13 09:04:04 volumio systemd[1]: Stopped Music Player Daemon.
May 13 09:04:04 volumio systemd[1]: Starting Music Player Daemon...
May 13 09:04:04 volumio volumio[3450]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:04 volumio sudo[3663]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 13 09:04:04 volumio sudo[3663]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:04 volumio sudo[3663]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 13 09:04:04 volumio sudo[3663]: pam_unix(sudo:session): session closed for user root
May 13 09:04:04 volumio volumio[3450]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:04 volumio volumio[3450]: info: [1747101844804] CoreMusicLibrary::Adding element Last_100
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:04 volumio volumio[3450]: info: [1747101844808] CoreMusicLibrary::Adding element Webradio
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:04 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:04:04 volumio volumio[3450]: info: Initializing BBC Radios
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 13 09:04:05 volumio volumio[3450]: info: Discovery: Getting this device information
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioGetState
May 13 09:04:05 volumio volumio[3450]: info: CorePlayQueue::getTrack 0
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:05 volumio volumio[3450]: info: [1747101845035] CoreMusicLibrary::Adding element Jellyfin
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: info: [jellyfin] Initialized plugin with device info: {"id":"88b6c06e-9c07-4af1-b4f1-01959a64deb2","host":"http://127.0.0.1","name":"Volumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":100,"mute":false,"artist":"","track":"","albumart":"http://127.0.0.1/albumart"}}
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:05 volumio volumio[3450]: info: [1747101845048] CoreMusicLibrary::Adding element SoundCloud
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: info: Creating Spotify config file
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:05 volumio volumio[3450]: info: [squeezelite_mc] Starting proxy server...
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:05 volumio volumio[3450]: info: [1747101845190] CoreMusicLibrary::Adding element YouTube2
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:05 volumio volumio[3450]: info: [1747101845239] CoreMusicLibrary::Adding element YouTube Music
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube Music
May 13 09:04:05 volumio volumio[3450]: info: AutoStart - onStart
May 13 09:04:05 volumio volumio[3450]: info: [now-playing] ConfigUpdater: config is up to date.
May 13 09:04:05 volumio volumio[3450]: info: Loading i18n strings for locale vi
May 13 09:04:05 volumio volumio[3450]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio volumio[3450]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:04:05 volumio volumio[3450]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:05 volumio volumio[3450]: info: FusionDsp - mixtype--------------------- None
May 13 09:04:05 volumio volumio[3450]: info: Loading i18n strings for locale vi
May 13 09:04:05 volumio volumio[3450]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio volumio[3450]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:04:05 volumio volumio[3450]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio sudo[3683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:04:05 volumio sudo[3683]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:05 volumio sudo[3683]: pam_unix(sudo:session): session closed for user root
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:05 volumio volumio[3450]: info: [1747101845433] CoreMusicLibrary::Adding element Pandora Radio
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube Music
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Pandora Radio
May 13 09:04:05 volumio volumio[3450]: info: [1747101845439] ControllerPandora::initializeMQTT
May 13 09:04:05 volumio volumio[3450]: info: [1747101845440] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:05 volumio volumio[3450]: info: [1747101845451] CoreMusicLibrary::Adding element Podcast
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube Music
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Pandora Radio
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Podcast
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:05 volumio volumio[3450]: info: [1747101845462] CoreMusicLibrary::Adding element SWARM Station
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube Music
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Pandora Radio
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Podcast
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SWARM Station
May 13 09:04:05 volumio volumio[3450]: info: Loading i18n strings for locale vi
May 13 09:04:05 volumio volumio[3450]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio volumio[3450]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:04:05 volumio volumio[3450]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:04:05 volumio volumio[3450]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:04:05 volumio volumio[3450]: Updating browse sources language
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube Music
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Pandora Radio
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Podcast
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SWARM Station
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube Music
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Pandora Radio
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Podcast
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SWARM Station
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:05 volumio volumio[3450]: info: [1747101845535] CoreMusicLibrary::Adding element Volusonic
May 13 09:04:05 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source YouTube Music
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Pandora Radio
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Podcast
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source SWARM Station
May 13 09:04:05 volumio volumio[3450]: Cannot find translation for source Volusonic
May 13 09:04:06 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:06 volumio volumio[3450]: info: [1747101846104] CoreMusicLibrary::Adding element Randomizer
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source Jellyfin
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source SoundCloud
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source YouTube2
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source YouTube Music
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source Pandora Radio
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source Podcast
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source SWARM Station
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source Volusonic
May 13 09:04:06 volumio volumio[3450]: Cannot find translation for source Randomizer
May 13 09:04:06 volumio volumio[3450]: info: Volumio Calling Home
May 13 09:04:06 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:04:06 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:04:06 volumio sudo[3713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
May 13 09:04:06 volumio sudo[3713]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:06 volumio volumio[3450]: info: [squeezelite_mc] Proxy server started on port 38147
May 13 09:04:06 volumio volumio[3450]: info: Preparing to generate the ALSA configuration file
May 13 09:04:06 volumio volumio[3450]: info: [1747101846344] ControllerPandora::initialSetup
May 13 09:04:06 volumio volumio[3450]: info: [1747101846351] ControllerPandora::PandoraHandler::init
May 13 09:04:06 volumio volumio[3450]: info: [1747101846353] ControllerPandora::PandoraHandler::loadErrorCodes
May 13 09:04:06 volumio volumio[3450]: info: [1747101846371] [Pandora] PandoraHandler::setMaxStationTracks: 16
May 13 09:04:06 volumio volumio[3450]: info: [1747101846375] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty
May 13 09:04:06 volumio volumio[3450]: info: [1747101846377] ControllerPandora::flushPandora
May 13 09:04:06 volumio volumio[3450]: info: CorePlayQueue::getQueue
May 13 09:04:06 volumio volumio[3450]: info: CorePlayQueue::clearPlayQueue
May 13 09:04:06 volumio volumio[3450]: info: CorePlayQueue::saveQueue
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::volumioPushQueue
May 13 09:04:06 volumio volumio[3450]: info: [1747101846391] ControllerPandora::validateAndSetAccountOptions
May 13 09:04:06 volumio volumio[3450]: error: [1747101846393] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings.
May 13 09:04:06 volumio mpd[3671]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 13 09:04:06 volumio mpd[3671]: output: No 'audio_output' defined in config file
May 13 09:04:06 volumio mpd[3671]: couldn't open play stream: No such file or directory
May 13 09:04:06 volumio mpd[3671]: sndio_output: Error opening default sndio device
May 13 09:04:06 volumio mpd[3671]: ALSA lib /home/volumio-fifo-plugin/src/pcm_volumiofifo.c:753:(_snd_pcm_volumiofifo_open) Failed to open output fifo /tmp/fusiondspfifo
May 13 09:04:06 volumio mpd[3671]: alsa_output: Error opening default ALSA device: No such file or directory
May 13 09:04:06 volumio mpd[3671]: output: Successfully detected a jack audio device
May 13 09:04:06 volumio mpd[3671]: zeroconf: No global port, disabling zeroconf
May 13 09:04:06 volumio systemd[1]: Started Music Player Daemon.
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::volumioRetrievevolume
May 13 09:04:06 volumio volumio[3450]: info: [now-playing] App is listening on port 4004.
May 13 09:04:06 volumio sudo[3660]: pam_unix(sudo:session): session closed for user root
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::volumioGetState
May 13 09:04:06 volumio volumio[3450]: info: CorePlayQueue::getTrack 0
May 13 09:04:06 volumio volumio[3450]: info: CoreStateMachine::pushState
May 13 09:04:06 volumio volumio[3450]: info: CorePlayQueue::getTrack 0
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::volumioPushState
May 13 09:04:06 volumio sudo[3650]: pam_unix(sudo:session): session closed for user root
May 13 09:04:06 volumio volumio[3450]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
May 13 09:04:06 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
May 13 09:04:06 volumio volumio[3450]: info: [squeezelite_mc] Server discovery started
May 13 09:04:06 volumio volumio[3450]: info: [squeezelite_mc] Player finder started
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:06 volumio volumio[3450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:04:06 volumio volumio[3450]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true
May 13 09:04:06 volumio volumio[3450]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 09:04:06 volumio volumio[3450]: Error: send ENETUNREACH 255.255.255.255:3483
May 13 09:04:06 volumio volumio[3450]: at doSend (dgram.js:714:16)
May 13 09:04:06 volumio volumio[3450]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18)
May 13 09:04:06 volumio volumio[3450]: at afterDns (dgram.js:660:5)
May 13 09:04:06 volumio volumio[3450]: at processTicksAndRejections (internal/process/task_queues.js:83:21) {
May 13 09:04:06 volumio volumio[3450]: errno: -101,
May 13 09:04:06 volumio volumio[3450]: code: 'ENETUNREACH',
May 13 09:04:06 volumio volumio[3450]: syscall: 'send',
May 13 09:04:06 volumio volumio[3450]: address: '255.255.255.255',
May 13 09:04:06 volumio volumio[3450]: port: 3483
May 13 09:04:06 volumio volumio[3450]: }
May 13 09:04:06 volumio volumio[3450]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 09:04:07 volumio sudo[3713]: pam_unix(sudo:session): session closed for user root
May 13 09:04:07 volumio volumio[3737]: cset: --> shielding system active with
May 13 09:04:07 volumio volumio[3737]: cset: "system" cpuset of CPUSPEC(1-3) with 225 tasks running
May 13 09:04:07 volumio volumio[3737]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
May 13 09:04:07 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
May 13 09:04:07 volumio sudo[3780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 09:03
May 13 09:04:07 volumio sudo[3780]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:07 volumio sudo[3780]: pam_unix(sudo:session): session closed for user root
May 13 09:04:07 volumio volumio-remote-updater[817]: [2025-05-13 09:04:07] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
May 13 09:04:07 volumio volumio-remote-updater[817]: [2025-05-13 09:04:07] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
May 13 09:04:07 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
May 13 09:04:07 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
May 13 09:04:07 volumio systemd[1]: Started dynamicswap service.
May 13 09:04:07 volumio systemd[1]: dynamicswap.service: Succeeded.
May 13 09:04:07 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
May 13 09:04:07 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 217.
May 13 09:04:07 volumio systemd[1]: Started dynamicswap service.
May 13 09:04:07 volumio systemd[1]: Stopped Volumio Backend Module.
May 13 09:04:07 volumio systemd[1]: Started Volumio Backend Module.
May 13 09:04:07 volumio systemd[1]: dynamicswap.service: Succeeded.
May 13 09:04:08 volumio volumio[3794]: info: -------------------------------------------
May 13 09:04:08 volumio volumio[3794]: info: ----- Volumio3 ----
May 13 09:04:08 volumio volumio[3794]: info: -------------------------------------------
May 13 09:04:08 volumio volumio[3794]: info: ----- System startup ----
May 13 09:04:08 volumio volumio[3794]: info: -------------------------------------------
May 13 09:04:09 volumio volumio[3794]: info: MYVOLUMIO Environment detected
May 13 09:04:09 volumio volumio[3794]: info: Plugin folders cleanup
May 13 09:04:09 volumio volumio[3794]: info: Scanning into folder /volumio/app/plugins/
May 13 09:04:09 volumio volumio[3794]: info: Scanning category audio_interface
May 13 09:04:09 volumio volumio[3794]: info: Scanning category miscellanea
May 13 09:04:09 volumio volumio[3794]: info: Scanning category music_service
May 13 09:04:09 volumio volumio[3794]: info: Scanning category plugins.json
May 13 09:04:09 volumio volumio[3794]: info: Scanning category system_controller
May 13 09:04:09 volumio volumio[3794]: info: Scanning category user_interface
May 13 09:04:09 volumio volumio[3794]: info: Scanning into folder /data/plugins/
May 13 09:04:09 volumio volumio[3794]: info: Scanning category audio_interface
May 13 09:04:09 volumio volumio[3794]: info: Scanning category music_service
May 13 09:04:09 volumio volumio[3794]: info: Scanning category peppymeterbasic
May 13 09:04:09 volumio volumio[3794]: info: Scanning category system_controller
May 13 09:04:09 volumio volumio[3794]: info: Scanning category system_hardware
May 13 09:04:09 volumio volumio[3794]: info: Scanning category user_interface
May 13 09:04:09 volumio volumio[3794]: info: Plugin folders cleanup completed
May 13 09:04:09 volumio volumio[3794]: info: -------------------------------------------
May 13 09:04:09 volumio volumio[3794]: info: ----- Core plugins startup ----
May 13 09:04:09 volumio volumio[3794]: info: -------------------------------------------
May 13 09:04:09 volumio volumio[3794]: info: Loading plugins from folder /volumio/app/plugins/
May 13 09:04:09 volumio volumio[3794]: info: Adding plugin upnp to MyMusic Plugins
May 13 09:04:09 volumio volumio[3794]: info: Adding plugin airplay_emulation to MyMusic Plugins
May 13 09:04:09 volumio volumio[3794]: info: Adding plugin upnp_browser to MyMusic Plugins
May 13 09:04:09 volumio volumio[3794]: info: Loading plugins from folder /data/plugins/
May 13 09:04:09 volumio volumio[3794]: info: Loading plugin "system"...
May 13 09:04:09 volumio volumio[3794]: info: Loading plugin "appearance"...
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "network"...
May 13 09:04:10 volumio volumio[3794]: info: Refreshing Cached IP Addresses
May 13 09:04:10 volumio sudo[3820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 13 09:04:10 volumio sudo[3820]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:10 volumio sudo[3820]: pam_unix(sudo:session): session closed for user root
May 13 09:04:10 volumio sudo[3822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 13 09:04:10 volumio sudo[3822]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:10 volumio sudo[3822]: pam_unix(sudo:session): session closed for user root
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "services"...
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "alsa_controller"...
May 13 09:04:10 volumio sudo[3835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 13 09:04:10 volumio sudo[3835]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:10 volumio sudo[3835]: pam_unix(sudo:session): session closed for user root
May 13 09:04:10 volumio volumio[3794]: warn: Unable to locate the audio output device BursonAudio USB Audio 2.0. Please configure a valid output device.
May 13 09:04:10 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "wizard"...
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "networkfs"...
May 13 09:04:10 volumio volumio[3794]: info: Starting Udev Watcher for removable devices
May 13 09:04:10 volumio volumio[3794]: info: Ignoring mount for partition: boot
May 13 09:04:10 volumio volumio[3794]: info: Ignoring mount for partition: volumio
May 13 09:04:10 volumio volumio[3794]: info: Ignoring mount for partition: volumio_data
May 13 09:04:10 volumio volumio[3794]: info: Ignoring mount for partition: boot
May 13 09:04:10 volumio volumio[3794]: info: Ignoring mount for partition: volumio
May 13 09:04:10 volumio volumio[3794]: info: Ignoring mount for partition: volumio_data
May 13 09:04:10 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "volumio_command_line_client"...
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "upnp"...
May 13 09:04:10 volumio volumio[3794]: info: [1747101850748] Starting Upmpd Daemon
May 13 09:04:10 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "my_music"...
May 13 09:04:10 volumio volumio[3794]: info: Loading plugin "mpd"...
May 13 09:04:11 volumio volumio[3794]: info: Loading plugin "upnp_browser"...
May 13 09:04:11 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:04:11 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:04:11 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:04:11 volumio volumio[3794]: info: Loading plugin "alarm-clock"...
May 13 09:04:11 volumio volumio[3794]: info: Loading plugin "airplay_emulation"...
May 13 09:04:11 volumio volumio[3794]: info: Starting Shairport Sync
May 13 09:04:11 volumio volumio[3794]: info: Loading plugin "last_100"...
May 13 09:04:11 volumio volumio[3794]: info: Loading plugin "webradio"...
May 13 09:04:11 volumio volumio[3794]: info: Loading plugin "i2s_dacs"...
May 13 09:04:11 volumio volumio[3794]: info: I2S DAC not set, start Auto-detection
May 13 09:04:11 volumio volumio[3794]: info: Loading plugin "volumiodiscovery"...
May 13 09:04:11 volumio volumio[3794]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 13 09:04:11 volumio volumio[3794]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:04:11 volumio volumio[3794]: *** WARNING *** For more information see
May 13 09:04:11 volumio node[3794]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 13 09:04:11 volumio volumio[3794]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 13 09:04:11 volumio volumio[3794]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:04:11 volumio volumio[3794]: *** WARNING *** For more information see
May 13 09:04:11 volumio node[3794]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:04:11 volumio node[3794]: *** WARNING *** For more information see
May 13 09:04:11 volumio node[3794]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 13 09:04:11 volumio node[3794]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 13 09:04:11 volumio node[3794]: *** WARNING *** For more information see
May 13 09:04:11 volumio volumio[3794]: info: Applying required configuration parameters for plugin volumiodiscovery
May 13 09:04:11 volumio volumio[3794]: info: Discovery: Started advertising with name: Volumio
May 13 09:04:11 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:04:11 volumio volumio[3794]: info: Loading plugin "jellyfin"...
May 13 09:04:12 volumio volumio[3794]: info: Loading plugin "soundcloud"...
May 13 09:04:12 volumio volumio-remote-updater[817]: [2025-05-13 09:04:12] [connect] Successful connection
May 13 09:04:12 volumio volumio[3794]: info: Loading plugin "spop"...
May 13 09:04:13 volumio volumio[3794]: info: Loading plugin "squeezelite_mc"...
May 13 09:04:13 volumio volumio[3794]: info: Loading plugin "youtube2"...
May 13 09:04:16 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:04:16 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:04:16 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:04:16 volumio volumio[3794]: info: Loading plugin "ytcr"...
May 13 09:04:17 volumio kernel: r8169 0000:02:00.0 eth0: Link is Up - 100Mbps/Full - flow control rx/tx
May 13 09:04:17 volumio dhcpcd[1340]: eth0: carrier acquired
May 13 09:04:17 volumio dhcpcd[1340]: eth0: IAID 4c:6c:91:6a
May 13 09:04:17 volumio dhcpcd[1340]: eth0: soliciting an IPv6 router
May 13 09:04:17 volumio dhcpcd[1340]: eth0: soliciting a DHCP lease
May 13 09:04:18 volumio ifplugd(eth0)[961]: Link beat detected.
May 13 09:04:18 volumio ifplugd(eth0)[961]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
May 13 09:04:18 volumio dhcpcd[3881]: sending commands to master dhcpcd process
May 13 09:04:18 volumio ifplugd(eth0)[961]: client: sending commands to master dhcpcd process
May 13 09:04:18 volumio dhcpcd[1340]: control command: /sbin/dhcpcd eth0
May 13 09:04:18 volumio ifplugd(eth0)[961]: Program executed successfully.
May 13 09:04:19 volumio volumio[3794]: info: Loading plugin "ytmusic"...
May 13 09:04:20 volumio dhcpcd[1340]: eth0: offered 192.168.1.237 from 192.168.1.1
May 13 09:04:20 volumio dhcpcd[1340]: eth0: probing address 192.168.1.237/24
May 13 09:04:21 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:04:21 volumio volumio-time-update[824]: volumio-time-update-util: Date not found in response
May 13 09:04:21 volumio volumio-time-update[824]: volumio-time-update-util: Retrying in 5 seconds...
May 13 09:04:21 volumio volumio[3794]: info: Loading plugin "autostart"...
May 13 09:04:22 volumio volumio[3794]: info: Applying required configuration parameters for plugin autostart
May 13 09:04:22 volumio volumio[3794]: info: AutoStart - onVolumioStart - read config.json
May 13 09:04:22 volumio volumio[3794]: info: Loading plugin "now_playing"...
May 13 09:04:23 volumio volumio[3794]: info: Loading plugin "outputs"...
May 13 09:04:23 volumio volumio[3794]: info: Loading plugin "albumart"...
May 13 09:04:23 volumio volumio[3794]: info: Plugin example_plugin is not enabled
May 13 09:04:23 volumio volumio[3794]: info: Loading plugin "inputs"...
May 13 09:04:23 volumio volumio[3794]: info: Loading plugin "updater_comm"...
May 13 09:04:23 volumio volumio[3794]: info: Plugin mpdemulation is not enabled
May 13 09:04:23 volumio volumio[3794]: info: Loading plugin "rest_api"...
May 13 09:04:23 volumio volumio[3794]: info: Loading plugin "websocket"...
May 13 09:04:23 volumio volumio[3794]: info: Starting Socket.io Server version 2.3.0
May 13 09:04:23 volumio volumio[3794]: info: Loading plugin "fusiondsp"...
May 13 09:04:23 volumio volumio[3794]: Forking 3 albumart workers
May 13 09:04:23 volumio volumio[3794]: info: Applying required configuration parameters for plugin fusiondsp
May 13 09:04:24 volumio volumio[3794]: info: Loading plugin "mpdoutput"...
May 13 09:04:24 volumio volumio[3794]: Starting albumart workers
May 13 09:04:24 volumio volumio[3794]: Starting albumart workers
May 13 09:04:24 volumio volumio[3794]: info: Loading plugin "RoonBridge"...
May 13 09:04:24 volumio volumio[3794]: Starting albumart workers
May 13 09:04:24 volumio volumio[3794]: info: Applying required configuration parameters for plugin RoonBridge
May 13 09:04:24 volumio volumio[3794]: info: Loading plugin "minidlna"...
May 13 09:04:24 volumio dhcpcd[1340]: eth0: leased 192.168.1.237 for 3600 seconds
May 13 09:04:24 volumio dhcpcd[1340]: eth0: adding route to 192.168.1.0/24
May 13 09:04:24 volumio dhcpcd[1340]: eth0: adding default route via 192.168.1.1
May 13 09:04:24 volumio avahi-daemon[823]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.237.
May 13 09:04:24 volumio avahi-daemon[823]: New relevant interface eth0.IPv4 for mDNS.
May 13 09:04:24 volumio avahi-daemon[823]: Registering new address record for 192.168.1.237 on eth0.IPv4.
May 13 09:04:25 volumio volumio-remote-updater[817]: [2025-05-13 09:04:25] [connect] Successful connection
May 13 09:04:25 volumio volumio[3794]: info: Applying required configuration parameters for plugin minidlna
May 13 09:04:25 volumio ntpd[941]: ntpd exiting on signal 15 (Terminated)
May 13 09:04:25 volumio volumio[3794]: info: Loading plugin "myb"...
May 13 09:04:25 volumio systemd[1]: Stopping Network Time Service...
May 13 09:04:25 volumio systemd[1]: ntp.service: Succeeded.
May 13 09:04:25 volumio systemd[1]: Stopped Network Time Service.
May 13 09:04:25 volumio systemd[1]: Starting Network Time Service...
May 13 09:04:25 volumio ntpd[4006]: ntpd 4.2.8p12@1.3728-o (1): Starting
May 13 09:04:25 volumio ntpd[4006]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
May 13 09:04:25 volumio systemd[1]: Started Network Time Service.
May 13 09:04:25 volumio ntpd[4012]: proto: precision = 0.224 usec (-22)
May 13 09:04:25 volumio ntpd[4012]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
May 13 09:04:25 volumio ntpd[4012]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
May 13 09:04:25 volumio ntpd[4012]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 868 days ago
May 13 09:04:25 volumio ntpd[4012]: Listen and drop on 0 v6wildcard [::]:123
May 13 09:04:25 volumio ntpd[4012]: Listen and drop on 1 v4wildcard 0.0.0.0:123
May 13 09:04:25 volumio ntpd[4012]: Listen normally on 2 lo 127.0.0.1:123
May 13 09:04:25 volumio ntpd[4012]: Listen normally on 3 eth0 192.168.1.237:123
May 13 09:04:25 volumio ntpd[4012]: Listening on routing socket on fd #20 for interface updates
May 13 09:04:25 volumio ntpd[4012]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized
May 13 09:04:25 volumio ntpd[4012]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized
May 13 09:04:25 volumio volumio[3794]: info: Applying required configuration parameters for plugin myb
May 13 09:04:25 volumio volumio[3794]: info: Loading plugin "pandora"...
May 13 09:04:26 volumio volumio[3794]: info: Applying required configuration parameters for plugin pandora
May 13 09:04:26 volumio volumio-time-update[824]: volumio-time-update-util: Fetching time from Volumio...
May 13 09:04:26 volumio volumio[3794]: info: Loading plugin "podcast"...
May 13 09:04:26 volumio volumio[3794]: info: ControllerPodcast::constructor
May 13 09:04:26 volumio volumio[3794]: info: Loading plugin "swarmstation"...
May 13 09:04:26 volumio ntpd[4012]: Soliciting pool server 103.70.115.65
May 13 09:04:26 volumio volumio[3794]: info: Applying required configuration parameters for plugin swarmstation
May 13 09:04:26 volumio volumio[3794]: info: [1747101866612] [Swarmstation] API delay: 5
May 13 09:04:26 volumio volumio[3794]: info: Loading plugin "volusonic"...
May 13 09:04:26 volumio volumio-time-update[824]: volumio-time-update-util: Setting system time to: 2025-05-13 09:04:31
May 13 09:04:26 volumio sudo[4028]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-05-13 09:04:31
May 13 09:04:26 volumio sudo[4028]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:26 volumio dbus-daemon[829]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.447' (uid=0 pid=4029 comm="timedatectl set-time 2025-05-13 09:04:31 ")
May 13 09:04:26 volumio systemd[1]: Starting Time & Date Service...
May 13 09:04:27 volumio dbus-daemon[829]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 13 09:04:27 volumio systemd[1]: Started Time & Date Service.
May 13 09:04:31 volumio systemd-timedated[4030]: Changed local time to Tue May 13 09:04:31 2025
May 13 09:04:31 volumio sudo[4028]: pam_unix(sudo:session): session closed for user root
May 13 09:04:31 volumio volumio-time-update[824]: volumio-time-update-util: System time updated successfully.
May 13 09:04:31 volumio systemd[1]: Started Volumio Time Update Utility.
May 13 09:04:31 volumio systemd[1]: Reached target Multi-User System.
May 13 09:04:31 volumio systemd[1]: Reached target Graphical Interface.
May 13 09:04:31 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
May 13 09:04:31 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
May 13 09:04:31 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
May 13 09:04:31 volumio systemd[1]: Startup finished in 25.253s (kernel) + 1h 21min 48.435s (userspace) = 1h 22min 13.689s.
May 13 09:04:31 volumio ntpd[4012]: Soliciting pool server 103.199.19.135
May 13 09:04:31 volumio ntpd[4012]: Soliciting pool server 103.184.124.254
May 13 09:04:31 volumio volumio[3794]: info: Applying required configuration parameters for plugin volusonic
May 13 09:04:31 volumio volumio[3794]: info: Plugin peppymeterbasic is not enabled
May 13 09:04:31 volumio volumio[3794]: info: Loading plugin "backup_restore"...
May 13 09:04:31 volumio volumio[3794]: info: Applying required configuration parameters for plugin backup_restore
May 13 09:04:31 volumio volumio[3794]: info: Loading plugin "music_services_shield"...
May 13 09:04:31 volumio volumio[3794]: info: Applying required configuration parameters for plugin music_services_shield
May 13 09:04:31 volumio volumio[3794]: info: Loading plugin "Systeminfo"...
May 13 09:04:32 volumio ntpd[4012]: Soliciting pool server 27.71.27.209
May 13 09:04:32 volumio ntpd[4012]: Soliciting pool server 115.165.161.155
May 13 09:04:32 volumio volumio[3794]: info: Loading plugin "peppyspectrum"...
May 13 09:04:32 volumio volumio[3794]: info: Loading plugin "randomizer"...
May 13 09:04:32 volumio volumio[3794]: info: Applying required configuration parameters for plugin randomizer
May 13 09:04:32 volumio volumio[3794]: info: Loading i18n strings for locale vi
May 13 09:04:32 volumio volumio[3794]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:04:32 volumio volumio[3794]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:04:32 volumio volumio[3794]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:04:32 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:04:32 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:04:32 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:04:32 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:04:32 volumio volumio[3794]: Updating browse sources language
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::initPlayerControls
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:04:32 volumio volumio[3794]: Express server listening on port 3000
May 13 09:04:32 volumio volumio[3794]: [Metrics] WebUI: 20s 636.09ms
May 13 09:04:32 volumio volumio[3794]: info: Setting Device type: x86
May 13 09:04:32 volumio volumio[3794]: info: CoreStateMachine::resetVolumioState
May 13 09:04:32 volumio volumio[3794]: info: CoreStateMachine::getcurrentVolume
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::volumioRetrievevolume
May 13 09:04:32 volumio volumio[3794]: info: CoreStateMachine::pushState
May 13 09:04:32 volumio volumio[3794]: info: CorePlayQueue::getTrack 0
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::volumioPushState
May 13 09:04:32 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:32 volumio sudo[4055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 13 09:04:32 volumio sudo[4055]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:32 volumio sudo[4055]: pam_unix(sudo:session): session closed for user root
May 13 09:04:32 volumio volumio[3794]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
May 13 09:04:32 volumio volumio[3794]: info: Completed loading Core Plugins
May 13 09:04:32 volumio sudo[4058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 13 09:04:32 volumio sudo[4058]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:32 volumio volumio[3794]: info: Preparing to generate the ALSA configuration file
May 13 09:04:33 volumio sudo[4058]: pam_unix(sudo:session): session closed for user root
May 13 09:04:33 volumio volumio[3794]: info: Volumio Network Manager: Network status updated: 0
May 13 09:04:33 volumio volumio[3794]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
May 13 09:04:33 volumio volumio[3794]: wlan0 Interface doesn't support scanning : Device or resource busy
May 13 09:04:33 volumio volumio[3794]: info: Cannot use regular scanning, forcing with ap-force
May 13 09:04:33 volumio sudo[4061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
May 13 09:04:33 volumio sudo[4061]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:33 volumio ntpd[4012]: Soliciting pool server 115.165.161.155
May 13 09:04:33 volumio ntpd[4012]: Soliciting pool server 115.165.161.155
May 13 09:04:36 volumio sudo[4061]: pam_unix(sudo:session): session closed for user root
May 13 09:04:36 volumio volumio[3794]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
May 13 09:04:36 volumio volumio[3794]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 13 09:04:36 volumio volumio[3794]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
May 13 09:04:36 volumio volumio[3794]: info: Reading ALSA contributions from plugins.
May 13 09:04:36 volumio volumio[3794]: info: Volumio Network Manager: Network status updated: 1
May 13 09:04:36 volumio volumio[3794]: Upnp client error: Error: This socket has been ended by the other party
May 13 09:04:36 volumio volumio[3794]: info: Cannot read play queue from file
May 13 09:04:36 volumio volumio[3794]: info: CoreStateMachine::setRepeat true single undefined
May 13 09:04:36 volumio volumio[3794]: info: CoreStateMachine::pushState
May 13 09:04:36 volumio volumio[3794]: info: CorePlayQueue::getTrack 0
May 13 09:04:36 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:04:36 volumio volumio[3794]: info: CoreCommandRouter::volumioPushState
May 13 09:04:36 volumio volumio[3794]: info: CoreStateMachine::setRandom true
May 13 09:04:36 volumio volumio[3794]: info: CoreStateMachine::pushState
May 13 09:04:36 volumio volumio[3794]: info: CorePlayQueue::getTrack 0
May 13 09:04:36 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 09:04:36 volumio volumio[3794]: info: CoreCommandRouter::volumioPushState
May 13 09:04:36 volumio volumio[3794]: info: Asound.conf file unchanged, so no further update is needed
May 13 09:04:36 volumio volumio[3794]: info: Output device has changed, restarting MPD
May 13 09:04:36 volumio sudo[4093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 13 09:04:36 volumio sudo[4093]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:37 volumio sudo[4093]: pam_unix(sudo:session): session closed for user root
May 13 09:04:37 volumio sudo[4095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 09:04:37 volumio sudo[4095]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:37 volumio sudo[4095]: pam_unix(sudo:session): session closed for user root
May 13 09:04:37 volumio volumio[3794]: info: Output device has changed, restarting Shairport Sync
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:37 volumio sudo[4099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 09:04:37 volumio sudo[4099]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:37 volumio systemd[1]: musicservicesshield.service: Succeeded.
May 13 09:04:37 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
May 13 09:04:37 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
May 13 09:04:37 volumio systemd[1]: Stopping Music Player Daemon...
May 13 09:04:37 volumio systemd[1]: mpd.service: Succeeded.
May 13 09:04:37 volumio systemd[1]: Stopped Music Player Daemon.
May 13 09:04:37 volumio systemd[1]: Starting Music Player Daemon...
May 13 09:04:37 volumio volumio[3794]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:04:37 volumio volumio[3794]: info: ___________ START PLUGINS ___________
May 13 09:04:37 volumio volumio[3794]: info: ControllerMpd::onStart: Initializing MPD
May 13 09:04:37 volumio volumio[3794]: info: Creating MPD Configuration file
May 13 09:04:37 volumio sudo[4102]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 13 09:04:37 volumio sudo[4102]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:37 volumio sudo[4102]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 13 09:04:37 volumio sudo[4102]: pam_unix(sudo:session): session closed for user root
May 13 09:04:37 volumio sudo[4107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 09:04:37 volumio sudo[4107]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:37 volumio sudo[4107]: pam_unix(sudo:session): session closed for user root
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:37 volumio volumio[3794]: info: [1747101877495] CoreMusicLibrary::Adding element Máy chủ Media
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:37 volumio sudo[4111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 09:04:37 volumio sudo[4111]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:37 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 13 09:04:37 volumio systemd[1]: mpd.service: Succeeded.
May 13 09:04:37 volumio systemd[1]: Stopped Music Player Daemon.
May 13 09:04:37 volumio systemd[1]: Starting Music Player Daemon...
May 13 09:04:37 volumio volumio[3794]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:37 volumio sudo[4114]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 13 09:04:37 volumio sudo[4114]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:37 volumio sudo[4114]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 13 09:04:37 volumio sudo[4114]: pam_unix(sudo:session): session closed for user root
May 13 09:04:37 volumio volumio[3794]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:37 volumio volumio[3794]: info: [1747101877730] CoreMusicLibrary::Adding element Last_100
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:37 volumio volumio[3794]: info: [1747101877735] CoreMusicLibrary::Adding element Webradio
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:37 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:04:37 volumio volumio[3794]: info: Initializing BBC Radios
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 13 09:04:38 volumio volumio[3794]: info: Discovery: Getting this device information
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::volumioGetState
May 13 09:04:38 volumio volumio[3794]: info: CorePlayQueue::getTrack 0
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:38 volumio volumio[3794]: info: [1747101878075] CoreMusicLibrary::Adding element Jellyfin
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:38 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:38 volumio volumio[3794]: info: [jellyfin] Initialized plugin with device info: {"id":"88b6c06e-9c07-4af1-b4f1-01959a64deb2","host":"http://192.168.1.237","name":"Volumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":100,"mute":false,"artist":"","track":"","albumart":"http://192.168.1.237/albumart"}}
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:38 volumio volumio[3794]: info: [1747101878098] CoreMusicLibrary::Adding element SoundCloud
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:38 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:38 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:38 volumio volumio[3794]: info: Creating Spotify config file
May 13 09:04:38 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:39 volumio volumio[3794]: info: [squeezelite_mc] Starting proxy server...
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:39 volumio volumio[3794]: info: [1747101879033] CoreMusicLibrary::Adding element YouTube2
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:39 volumio volumio[3794]: info: [1747101879083] CoreMusicLibrary::Adding element YouTube Music
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube Music
May 13 09:04:39 volumio volumio[3794]: info: AutoStart - onStart
May 13 09:04:39 volumio volumio[3794]: info: [now-playing] ConfigUpdater: config is up to date.
May 13 09:04:39 volumio volumio[3794]: info: Loading i18n strings for locale vi
May 13 09:04:39 volumio volumio[3794]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:04:39 volumio volumio[3794]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:39 volumio volumio[3794]: info: FusionDsp - mixtype--------------------- None
May 13 09:04:39 volumio sudo[4133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
May 13 09:04:39 volumio sudo[4133]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:39 volumio volumio[3794]: info: Loading i18n strings for locale vi
May 13 09:04:39 volumio volumio[3794]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:04:39 volumio volumio[3794]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:04:39 volumio sudo[4133]: pam_unix(sudo:session): session closed for user root
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:39 volumio volumio[3794]: info: [1747101879345] CoreMusicLibrary::Adding element Pandora Radio
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube Music
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Pandora Radio
May 13 09:04:39 volumio volumio[3794]: info: [1747101879350] ControllerPandora::initializeMQTT
May 13 09:04:39 volumio volumio[3794]: info: [1747101879351] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:39 volumio volumio[3794]: info: [1747101879365] CoreMusicLibrary::Adding element Podcast
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube Music
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Pandora Radio
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Podcast
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:39 volumio volumio[3794]: info: [1747101879385] CoreMusicLibrary::Adding element SWARM Station
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube Music
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Pandora Radio
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Podcast
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SWARM Station
May 13 09:04:39 volumio volumio[3794]: info: Loading i18n strings for locale vi
May 13 09:04:39 volumio volumio[3794]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 13 09:04:39 volumio volumio[3794]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
May 13 09:04:39 volumio volumio[3794]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
May 13 09:04:39 volumio volumio[3794]: Updating browse sources language
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube Music
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Pandora Radio
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Podcast
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SWARM Station
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube Music
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Pandora Radio
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Podcast
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SWARM Station
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:39 volumio volumio[3794]: info: [1747101879508] CoreMusicLibrary::Adding element Volusonic
May 13 09:04:39 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source YouTube Music
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Pandora Radio
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Podcast
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source SWARM Station
May 13 09:04:39 volumio volumio[3794]: Cannot find translation for source Volusonic
May 13 09:04:40 volumio mpd[4121]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 13 09:04:40 volumio mpd[4121]: output: No 'audio_output' defined in config file
May 13 09:04:40 volumio mpd[4121]: couldn't open play stream: No such file or directory
May 13 09:04:40 volumio mpd[4121]: sndio_output: Error opening default sndio device
May 13 09:04:40 volumio mpd[4121]: ALSA lib /home/volumio-fifo-plugin/src/pcm_volumiofifo.c:753:(_snd_pcm_volumiofifo_open) Failed to open output fifo /tmp/fusiondspfifo
May 13 09:04:40 volumio mpd[4121]: alsa_output: Error opening default ALSA device: No such file or directory
May 13 09:04:40 volumio mpd[4121]: output: Successfully detected a jack audio device
May 13 09:04:40 volumio mpd[4121]: zeroconf: No global port, disabling zeroconf
May 13 09:04:40 volumio systemd[1]: Started Music Player Daemon.
May 13 09:04:40 volumio sudo[4111]: pam_unix(sudo:session): session closed for user root
May 13 09:04:40 volumio sudo[4099]: pam_unix(sudo:session): session closed for user root
May 13 09:04:40 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 13 09:04:40 volumio sudo[4173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
May 13 09:04:40 volumio sudo[4173]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 13 09:04:40 volumio volumio[3794]: info: [1747101880239] CoreMusicLibrary::Adding element Randomizer
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source Jellyfin
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source SoundCloud
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source YouTube2
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source YouTube Music
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source Pandora Radio
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source Podcast
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source SWARM Station
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source Volusonic
May 13 09:04:40 volumio volumio[3794]: Cannot find translation for source Randomizer
May 13 09:04:40 volumio volumio[3794]: info: Volumio Calling Home
May 13 09:04:40 volumio volumio[3794]: info: [squeezelite_mc] Proxy server started on port 40951
May 13 09:04:40 volumio volumio[3794]: info: Preparing to generate the ALSA configuration file
May 13 09:04:40 volumio volumio[3794]: info: [1747101880428] ControllerPandora::initialSetup
May 13 09:04:40 volumio volumio[3794]: info: [1747101880433] ControllerPandora::PandoraHandler::init
May 13 09:04:40 volumio volumio[3794]: info: [1747101880435] ControllerPandora::PandoraHandler::loadErrorCodes
May 13 09:04:40 volumio volumio[3794]: info: [1747101880466] [Pandora] PandoraHandler::setMaxStationTracks: 16
May 13 09:04:40 volumio volumio[3794]: info: [1747101880470] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty
May 13 09:04:40 volumio volumio[3794]: info: [1747101880471] ControllerPandora::flushPandora
May 13 09:04:40 volumio volumio[3794]: info: CorePlayQueue::getQueue
May 13 09:04:40 volumio volumio[3794]: info: CorePlayQueue::clearPlayQueue
May 13 09:04:40 volumio volumio[3794]: info: CorePlayQueue::saveQueue
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::volumioPushQueue
May 13 09:04:40 volumio volumio[3794]: info: [1747101880478] ControllerPandora::validateAndSetAccountOptions
May 13 09:04:40 volumio volumio[3794]: error: [1747101880479] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings.
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::volumioRetrievevolume
May 13 09:04:40 volumio volumio[3794]: info: [now-playing] App is listening on port 4004.
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::volumioGetState
May 13 09:04:40 volumio volumio[3794]: info: CorePlayQueue::getTrack 0
May 13 09:04:40 volumio volumio[3794]: info: CoreStateMachine::pushState
May 13 09:04:40 volumio volumio[3794]: info: CorePlayQueue::getTrack 0
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::volumioPushState
May 13 09:04:40 volumio volumio[3794]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
May 13 09:04:40 volumio volumio[3794]: info: [squeezelite_mc] Server discovery started
May 13 09:04:40 volumio volumio[3794]: info: [squeezelite_mc] Player finder started
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:40 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 09:04:40 volumio volumio[3794]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true
May 13 09:04:40 volumio volumio[4167]: cset: --> shielding system active with
May 13 09:04:40 volumio volumio[4167]: cset: "system" cpuset of CPUSPEC(1-3) with 247 tasks running
May 13 09:04:40 volumio volumio[4167]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
May 13 09:04:40 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
May 13 09:04:40 volumio volumio[3794]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 13 09:04:40 volumio volumio[3794]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
May 13 09:04:40 volumio volumio[3794]: info: Reading ALSA contributions from plugins.
May 13 09:04:40 volumio volumio[3794]: warn: [squeezelite_mc] No supported ALSA formats found for card 2
May 13 09:04:40 volumio volumio[3794]: warn: [squeezelite_mc] No ALSA formats returned for card 2
May 13 09:04:40 volumio volumio[3794]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"volumio","dsdFormat":null,"card":"2","mixerType":"None","mixer":null}
May 13 09:04:40 volumio volumio[3794]: 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
May 13 09:04:40 volumio volumio[3794]: info: minidlna: Found miniDLNA version 1.2.1
May 13 09:04:40 volumio volumio[3794]: info: minidlna: Starting minidlna.service
May 13 09:04:40 volumio sudo[4173]: pam_unix(sudo:session): session closed for user root
May 13 09:04:41 volumio sudo[4208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
May 13 09:04:41 volumio sudo[4208]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:41 volumio sudo[4210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service
May 13 09:04:41 volumio sudo[4210]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:41 volumio sudo[4208]: pam_unix(sudo:session): session closed for user root
May 13 09:04:41 volumio volumio[3794]: info: MPD Permissions set
May 13 09:04:41 volumio volumio[3794]: info: MPD Permissions set
May 13 09:04:41 volumio volumio[3794]: info: Upmpdcli Daemon Started
May 13 09:04:41 volumio volumio[3794]: info: Discovery: adding 88b6c06e-9c07-4af1-b4f1-01959a64deb2
May 13 09:04:41 volumio volumio[3794]: info: Discovery: Found device Volumio
May 13 09:04:41 volumio volumio[3794]: info: CoreCommandRouter::volumioGetState
May 13 09:04:41 volumio volumio[3794]: info: CorePlayQueue::getTrack 0
May 13 09:04:41 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server.
May 13 09:04:41 volumio sudo[4210]: pam_unix(sudo:session): session closed for user root
May 13 09:04:41 volumio volumio[3794]: info: [squeezelite_mc] Executing alsactl -L -R nrestore
May 13 09:04:41 volumio sudo[4218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore
May 13 09:04:41 volumio sudo[4218]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:41 volumio sudo[4218]: pam_unix(sudo:session): session closed for user root
May 13 09:04:41 volumio sudo[4222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh
May 13 09:04:41 volumio sudo[4222]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:41 volumio systemd[1]: Reloading.
May 13 09:04:41 volumio volumio[3794]: info: camilladsp service started and running in background, instance 1
May 13 09:04:41 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 09:04:41 volumio volumio[3794]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card
May 13 09:04:41 volumio volumio[3794]: cannot open device 'volumioHw': No such device
May 13 09:04:41 volumio volumio[3794]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
May 13 09:04:41 volumio volumio[3794]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card
May 13 09:04:41 volumio volumio[3794]: cannot open device 'volumioHw': No such device
May 13 09:04:41 volumio volumio[3794]: info: FusionDsp loaded
May 13 09:04:41 volumio volumio[3794]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 13 09:04:41 volumio sudo[4255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
May 13 09:04:41 volumio sudo[4255]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 09:04:41 volumio volumio[3794]: info: FusionDsp - Reporting Fusion DSP Enabled
May 13 09:04:41 volumio volumio[3794]: info: Adding Signal Path Element [object Object]
May 13 09:04:41 volumio volumio[3794]: info: Adding fusiondspeq DSP Signal Path Element
May 13 09:04:41 volumio volumio[3794]: info: FusionDsp - ---- installed callbackRead
May 13 09:04:41 volumio volumio[3794]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 09:04:41 volumio volumio[3794]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
May 13 09:04:41 volumio volumio[3794]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19)
May 13 09:04:41 volumio volumio[3794]: at onErrorNT (internal/child_process.js:472:16)
May 13 09:04:41 volumio volumio[3794]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
May 13 09:04:41 volumio volumio[3794]: at runNextTicks (internal/process/task_queues.js:64:3)
May 13 09:04:41 volumio volumio[3794]: at listOnTimeout (internal/timers.js:526:9)
May 13 09:04:41 volumio volumio[3794]: at processTimers (internal/timers.js:500:7) {
May 13 09:04:41 volumio volumio[3794]: errno: -2,
May 13 09:04:41 volumio volumio[3794]: code: 'ENOENT',
May 13 09:04:41 volumio volumio[3794]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
May 13 09:04:41 volumio volumio[3794]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
May 13 09:04:41 volumio volumio[3794]: spawnargs: [
May 13 09:04:41 volumio volumio[3794]: '-p',
May 13 09:04:41 volumio volumio[3794]: 9876,
May 13 09:04:41 volumio volumio[3794]: '-o',
May 13 09:04:41 volumio volumio[3794]: '/tmp/camilladsp.log',
May 13 09:04:41 volumio volumio[3794]: '-l',
May 13 09:04:41 volumio volumio[3794]: 'warn',
May 13 09:04:41 volumio volumio[3794]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
May 13 09:04:41 volumio volumio[3794]: ]
May 13 09:04:41 volumio volumio[3794]: }
May 13 09:04:41 volumio volumio[3794]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 09:04:41 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
May 13 09:04:42 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
May 13 09:04:42 volumio sudo[4266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 09:03
May 13 09:04:42 volumio sudo[4266]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST"
VOLUMIO_VERSION="3.804"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"