-- Logs begin at Fri 2025-06-20 07:59:07 UTC, end at Sat 2025-12-13 13:42:25 UTC. -- Dec 13 13:41:00 volumio volumio[1617]: info: Loading plugin "alsa_controller"... Dec 13 13:41:00 volumio sudo[1643]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:00 volumio sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 13:41:00 volumio sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:00 volumio sudo[1646]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:00 volumio volumio[1617]: info: Loading plugin "wizard"... Dec 13 13:41:00 volumio volumio[1617]: info: Loading plugin "volumio_command_line_client"... Dec 13 13:41:00 volumio volumio[1617]: info: Loading plugin "upnp"... Dec 13 13:41:00 volumio volumio[1617]: info: [1765633260243] Starting Upmpd Daemon Dec 13 13:41:00 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 13:41:00 volumio volumio[1617]: info: Loading plugin "my_music"... Dec 13 13:41:00 volumio volumio[1617]: info: Loading plugin "mpd"... Dec 13 13:41:01 volumio volumio[1617]: info: Loading plugin "upnp_browser"... Dec 13 13:41:01 volumio volumio[1617]: info: Loading plugin "networkfs"... Dec 13 13:41:01 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 13:41:01 volumio volumio[1617]: info: Loading plugin "alarm-clock"... Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "airplay_emulation"... Dec 13 13:41:02 volumio volumio[1617]: info: Starting Shairport Sync Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "last_100"... Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "webradio"... Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "i2s_dacs"... Dec 13 13:41:02 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "volumiodiscovery"... Dec 13 13:41:02 volumio volumio[1617]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 13 13:41:02 volumio node[1617]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 13 13:41:02 volumio node[1617]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 13:41:02 volumio node[1617]: *** WARNING *** For more information see Dec 13 13:41:02 volumio node[1617]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 13 13:41:02 volumio node[1617]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 13:41:02 volumio node[1617]: *** WARNING *** For more information see Dec 13 13:41:02 volumio volumio[1617]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 13:41:02 volumio volumio[1617]: *** WARNING *** For more information see Dec 13 13:41:02 volumio volumio[1617]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 13 13:41:02 volumio volumio[1617]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 13:41:02 volumio volumio[1617]: *** WARNING *** For more information see Dec 13 13:41:02 volumio volumio[1617]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 13 13:41:02 volumio volumio[1617]: Discovery: StartAdv! undefined Dec 13 13:41:02 volumio volumio[1617]: Discovery: Started advertising... Volumio - undefined Dec 13 13:41:02 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "outputs"... Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "albumart"... Dec 13 13:41:02 volumio volumio[1617]: info: Plugin example_plugin is not enabled Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "inputs"... Dec 13 13:41:02 volumio volumio[1617]: info: Loading plugin "updater_comm"... Dec 13 13:41:03 volumio volumio[1617]: info: Plugin mpdemulation is not enabled Dec 13 13:41:03 volumio volumio[1617]: info: Loading plugin "rest_api"... Dec 13 13:41:03 volumio volumio[1617]: info: Loading plugin "websocket"... Dec 13 13:41:03 volumio volumio[1617]: info: ___________ START PLUGINS ___________ Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 13 13:41:03 volumio volumio[1617]: info: [1765633263293] CoreMusicLibrary::Adding element Media Servers Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: Forking 3 albumart workers Dec 13 13:41:03 volumio volumio[1617]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 13 13:41:03 volumio volumio[1617]: info: [1765633263522] CoreMusicLibrary::Adding element Last_100 Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 13 13:41:03 volumio volumio[1617]: info: [1765633263532] CoreMusicLibrary::Adding element Webradio Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 13 13:41:03 volumio volumio[1617]: info: ------------------------------------------- Dec 13 13:41:03 volumio volumio[1617]: info: ----- MyVolumio plugins startup ---- Dec 13 13:41:03 volumio volumio[1617]: info: ------------------------------------------- Dec 13 13:41:03 volumio volumio[1617]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 13 13:41:03 volumio volumio[1617]: info: Loading i18n strings for locale zh Dec 13 13:41:03 volumio volumio[1617]: Updating browse sources language Dec 13 13:41:03 volumio volumio[1617]: Cannot find translation for sourceMedia Servers Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::initPlayerControls Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: info: BOOT COMPLETED Dec 13 13:41:03 volumio volumio[1617]: [Metrics] CommandRouter: 9s 528.17ms Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 13:41:03 volumio volumio[1617]: aplay: main:722: audio open error: Device or resource busy Dec 13 13:41:03 volumio volumio[1617]: Cannot play startup sound Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::Close All Modals sent Dec 13 13:41:03 volumio volumio[1617]: info: CoreCommandRouter::Close All Modals sent Dec 13 13:41:03 volumio volumio[1617]: Express server listening on port 3000 Dec 13 13:41:03 volumio volumio[1617]: [Metrics] WebUI: 10s 550.34ms Dec 13 13:41:03 volumio volumio[1617]: Volumio Calling Home Dec 13 13:41:04 volumio volumio[1617]: info: CoreStateMachine::resetVolumioState Dec 13 13:41:04 volumio volumio[1617]: info: CoreStateMachine::getcurrentVolume Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::volumioRetrievevolume Dec 13 13:41:04 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:04 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:04 volumio volumio[1617]: info: CoreStateMachine::updateTrackBlock Dec 13 13:41:04 volumio volumio[1617]: info: CorePlayQueue::getTrackBlock Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::volumioRetrievevolume Dec 13 13:41:04 volumio volumio[1617]: info: Setting Device type: Raspberry PI Dec 13 13:41:04 volumio volumio[1617]: info: MPD running with PID661 Dec 13 13:41:04 volumio volumio[1617]: ,establishing connection Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 13 13:41:04 volumio volumio[1617]: info: Discovery: Getting this device information Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:04 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:04 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:05 volumio volumio[1617]: Starting albumart workers Dec 13 13:41:05 volumio volumio[1617]: Starting albumart workers Dec 13 13:41:05 volumio volumio[1617]: Starting albumart workers Dec 13 13:41:05 volumio volumio[1617]: info: Volumio called home Dec 13 13:41:05 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:05 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:05 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:05 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:05 volumio volumio[1617]: info: Reloading queue from file Dec 13 13:41:05 volumio volumio[1617]: info: CoreStateMachine::setRepeat false single undefined Dec 13 13:41:05 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:05 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:05 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:05 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:05 volumio volumio[1617]: info: CoreStateMachine::setRandom true Dec 13 13:41:05 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:05 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:05 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:05 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 13 13:41:06 volumio volumio[1617]: info: Discovery: Getting this device information Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:06 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:06 volumio volumio[1617]: info: Starting Shairport Sync Dec 13 13:41:06 volumio volumio[1617]: info: Starting Shairport Sync Dec 13 13:41:06 volumio sudo[1723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 13 13:41:06 volumio sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:06 volumio sudo[1729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 13 13:41:06 volumio sudo[1729]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 13 13:41:06 volumio volumio[1617]: Discovery: adding 4435f77c-4c8d-4050-92cf-d51ed04cdd77 Dec 13 13:41:06 volumio volumio[1617]: info: mDNS: Found device Volumio Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:06 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:06 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 13 13:41:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 13 13:41:06 volumio sudo[1723]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 13 13:41:06 volumio volumio[1617]: info: Discovery: Getting this device information Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:06 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:06 volumio sudo[1729]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:06 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 13 13:41:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:06 volumio volumio[1617]: info: Dec 13 13:41:06 volumio volumio[1617]: ---------------------------- Client requests Volume 50 Dec 13 13:41:06 volumio volumio[1617]: info: VolumeController::SetAlsaVolume50 Dec 13 13:41:06 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:06 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:06 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 13 13:41:07 volumio volumio[1617]: info: Setting volume on startup at 50 Dec 13 13:41:07 volumio volumio[1617]: info: Shairport-Sync Started Dec 13 13:41:07 volumio volumio[1617]: Error adding Membership: Error: addMembership EINVAL Dec 13 13:41:07 volumio volumio[1617]: info: Shairport-Sync Started Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 13 13:41:07 volumio volumio[1617]: info: Discovery: Getting this device information Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:07 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:07 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:07 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 13:41:08 volumio volumio-remote-updater[616]: [2025-12-13 13:41:08] [connect] Successful connection Dec 13 13:41:08 volumio volumio-remote-updater[616]: [2025-12-13 13:41:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1765633268 101 Dec 13 13:41:08 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:08 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:08 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 13 13:41:08 volumio volumio[1617]: info: Listing playlists Dec 13 13:41:08 volumio volumio[1617]: info: CoreCommandRouter::volumioGetQueue Dec 13 13:41:08 volumio volumio[1617]: info: CoreStateMachine::getQueue Dec 13 13:41:08 volumio volumio[1617]: info: CorePlayQueue::getQueue Dec 13 13:41:08 volumio volumio[1617]: info: CoreCommandRouter::volumioGetVisibleSources Dec 13 13:41:08 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 13:41:10 volumio sudo[1785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 13 13:41:10 volumio sudo[1785]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:10 volumio sudo[1785]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:10 volumio sudo[1788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 13:41:10 volumio sudo[1788]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:10 volumio sudo[1797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 13 13:41:10 volumio sudo[1788]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:10 volumio sudo[1797]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:10 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Dec 13 13:41:10 volumio sudo[1797]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:10 volumio volumio[1617]: info: Upmpdcli Daemon Started Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 13 13:41:12 volumio volumio[1617]: info: Adding plugin bluetooth to MyMusic Plugins Dec 13 13:41:12 volumio volumio[1617]: info: Adding plugin cd_controller to MyMusic Plugins Dec 13 13:41:12 volumio volumio[1617]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 13 13:41:12 volumio volumio[1617]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 13 13:41:13 volumio volumio[1617]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 13 13:41:14 volumio volumio[1617]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 13 13:41:14 volumio volumio[1617]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 13 13:41:14 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 13:41:14 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 13:41:14 volumio volumio[1617]: info: Starting MyVolumio Remote Streaming Endpoints Dec 13 13:41:14 volumio volumio[1617]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 13 13:41:14 volumio volumio[1617]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 13 13:41:14 volumio volumio[1617]: info: Streaming services startup Dec 13 13:41:14 volumio volumio[1617]: info: Starting Streaming Daemon Dec 13 13:41:14 volumio sudo[1818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 13 13:41:14 volumio sudo[1818]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:14 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 13 13:41:14 volumio volumio[1617]: info: MyVolumio not started Dec 13 13:41:14 volumio volumio[1617]: info: Initializing device activation check Dec 13 13:41:14 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 13 13:41:14 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 13 13:41:14 volumio volumio[1617]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 13 13:41:14 volumio sudo[1818]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:14 volumio volumio-streaming-daemon[1828]: ############################ Dec 13 13:41:14 volumio volumio-streaming-daemon[1828]: # Volumio Streaming Daemon # Dec 13 13:41:14 volumio volumio-streaming-daemon[1828]: # Running on port 7777 # Dec 13 13:41:14 volumio volumio-streaming-daemon[1828]: ############################ Dec 13 13:41:14 volumio volumio-streaming-daemon[1828]: Environment: production Dec 13 13:41:17 volumio volumio-streaming-daemon[1828]: Environment: production Dec 13 13:41:17 volumio volumio[1617]: info: Fetching Streaming Services browse cache Dec 13 13:41:17 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 13 13:41:17 volumio sudo[1845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 13 13:41:17 volumio sudo[1845]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:17 volumio sudo[1845]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:17 volumio sudo[1851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 13 13:41:17 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:17 volumio sudo[1863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 13 13:41:17 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:17 volumio sudo[1863]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:17 volumio sudo[1873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 13 13:41:17 volumio sudo[1863]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:17 volumio sudo[1873]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:17 volumio sudo[1885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 13 13:41:17 volumio sudo[1873]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:17 volumio sudo[1885]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:17 volumio sudo[1885]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:17 volumio sudo[1896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 13:41:17 volumio sudo[1896]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:17 volumio sudo[1896]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:17 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 13 13:41:17 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 13 13:41:17 volumio volumio[1617]: info: Discovery: Getting this device information Dec 13 13:41:17 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:17 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:17 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 13 13:41:17 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:17 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 13 13:41:18 volumio volumio[1617]: info: Discovery: Getting this device information Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:18 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:18 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 13 13:41:18 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 13 13:41:18 volumio sudo[1915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 13 13:41:18 volumio sudo[1915]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:18 volumio sudo[1918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 13:41:18 volumio sudo[1915]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:18 volumio sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:18 volumio sudo[1918]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:19 volumio sudo[1935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 13 13:41:19 volumio sudo[1935]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:19 volumio sudo[1938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 13:41:19 volumio sudo[1935]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:19 volumio sudo[1938]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 13 13:41:19 volumio sudo[1938]: pam_unix(sudo:session): session closed for user root Dec 13 13:41:19 volumio volumio[1617]: info: CoreCommandRouter::volumioGetState Dec 13 13:41:19 volumio volumio[1617]: info: CorePlayQueue::getTrack 0 Dec 13 13:41:19 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 13 13:41:19 volumio volumio[1617]: info: Listing playlists Dec 13 13:41:19 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 13 13:41:19 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 13 13:41:19 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 13 13:41:19 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 13 13:41:25 volumio volumio[1617]: info: CoreCommandRouter::volumioGetQueue Dec 13 13:41:25 volumio volumio[1617]: info: CoreStateMachine::getQueue Dec 13 13:41:25 volumio volumio[1617]: info: CorePlayQueue::getQueue Dec 13 13:41:25 volumio volumio[1617]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/BEYOND/%E5%86%8D%E8%A7%81%E7%90%86%E6%83%B3/abef6f0f-cd07-490b-824f-f9f9c5abb4e8.jpg' Dec 13 13:41:25 volumio volumio[1617]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/A-Lin/%E5%A4%B1%E6%81%8B%E6%97%A0%E7%BD%AA/1e9c6bca-2a1c-4476-884d-8ad1e91d5f04.jpg' Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::volumioPlay Dec 13 13:41:30 volumio volumio[1617]: UNSET VOLATILE Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::play index 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::stop Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 13 13:41:30 volumio volumio[1617]: UNSET VOLATILE Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::play index undefined Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::startPlaybackTimer Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::clearAddPlayTracks USB/5A80-A105/自作自受/BEYOND - 愿我能+谁伴我闯荡+ 灰色轨迹 (Live).ogg Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand stop Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand stop took 46 milliseconds Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand clear Dec 13 13:41:30 volumio volumio[1617]: info: Dec 13 13:41:30 volumio volumio[1617]: ---------------------------- MPD announces state update: player Dec 13 13:41:30 volumio volumio[1617]: info: Dec 13 13:41:30 volumio volumio[1617]: ---------------------------- MPD announces system playlist update Dec 13 13:41:30 volumio volumio[1617]: info: Ignoring MPD Status Update Dec 13 13:41:30 volumio volumio[1617]: info: ControllerMpd::getState Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand status Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand clear took 10 milliseconds Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand add "USB/5A80-A105/自作自受/BEYOND - 愿我能+谁伴我闯荡+ 灰色轨迹 (Live).ogg" Dec 13 13:41:30 volumio volumio[1617]: error: updateQueue error: null Dec 13 13:41:30 volumio volumio[1617]: info: Dec 13 13:41:30 volumio volumio[1617]: ---------------------------- MPD announces system playlist update Dec 13 13:41:30 volumio volumio[1617]: info: Ignoring MPD Status Update Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand status took 10 milliseconds Dec 13 13:41:30 volumio volumio[1617]: info: ------------------------------ 21ms Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand add "USB/5A80-A105/自作自受/BEYOND - 愿我能+谁伴我闯荡+ 灰色轨迹 (Live).ogg" took 15 milliseconds Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::parseState Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand play Dec 13 13:41:30 volumio volumio[1617]: info: ControllerMpd::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::servicePushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 13 13:41:30 volumio volumio[1617]: verbose: CURRENT POSITION 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::syncState stateService stop Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::syncState currentStatus stop Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:30 volumio volumio[1617]: info: No code Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:30 volumio volumio[1617]: info: ------------------------------ 89ms Dec 13 13:41:30 volumio volumio[1617]: info: ------------------------------ 81ms Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand play took 66 milliseconds Dec 13 13:41:30 volumio volumio[1617]: info: Dec 13 13:41:30 volumio volumio[1617]: ---------------------------- MPD announces state update: player Dec 13 13:41:30 volumio volumio[1617]: info: ControllerMpd::getState Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand status Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand status took 45 milliseconds Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::parseState Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 13:41:30 volumio volumio[1617]: info: Dec 13 13:41:30 volumio volumio[1617]: ---------------------------- MPD announces state update: player Dec 13 13:41:30 volumio volumio[1617]: info: ControllerMpd::getState Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand status Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::parseTrackInfo Dec 13 13:41:30 volumio volumio[1617]: info: ControllerMpd::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::servicePushState Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":907,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿我能+谁伴我闯荡+ 灰色轨迹 (Live)","artist":"BEYOND","album":"歌曲合辑","uri":"USB/5A80-A105/自作自受/BEYOND - 愿我能+谁伴我闯荡+ 灰色轨迹 (Live).ogg","trackType":"ogg"} Dec 13 13:41:30 volumio volumio[1617]: verbose: CURRENT POSITION 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::syncState stateService play Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::syncState currentStatus stop Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:30 volumio volumio[1617]: info: ------------------------------ 85ms Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand status took 32 milliseconds Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::parseState Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 13:41:30 volumio volumio[1617]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 13 13:41:30 volumio volumio[1617]: verbose: ControllerMpd::parseTrackInfo Dec 13 13:41:30 volumio volumio[1617]: info: ControllerMpd::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::servicePushState Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":907,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿我能+谁伴我闯荡+ 灰色轨迹 (Live)","artist":"BEYOND","album":"歌曲合辑","uri":"USB/5A80-A105/自作自受/BEYOND - 愿我能+谁伴我闯荡+ 灰色轨迹 (Live).ogg","trackType":"ogg"} Dec 13 13:41:30 volumio volumio[1617]: verbose: CURRENT POSITION 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::syncState stateService play Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::syncState currentStatus play Dec 13 13:41:30 volumio volumio[1617]: info: Received an update from plugin. extracting info from payload Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:30 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:30 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:30 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:30 volumio volumio[1617]: info: ------------------------------ 93ms Dec 13 13:41:33 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 13 13:41:33 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 13:41:35 volumio volumio[1617]: info: CoreCommandRouter::volumioGetVisibleSources Dec 13 13:41:35 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 13:41:43 volumio volumio[1617]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/%E5%A5%87%E5%B9%BB%E6%97%85%E7%A8%8B/e4556af7-ebc6-4f7b-b923-5fff7ff8ca83.jpg' Dec 13 13:41:43 volumio volumio[1617]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Twins/Such%20A%20Better%20Day/32818948-0143-4b91-a823-047a5651dd1f.png' Dec 13 13:41:49 volumio volumio[1617]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E4%BA%AE%E5%A3%B0open/5383167c-ad22-478f-8c74-79294ba5a073.jpg' Dec 13 13:41:50 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 13 13:41:50 volumio volumio[1617]: info: CURURI: playlists Dec 13 13:41:50 volumio volumio[1617]: info: Listing playlists Dec 13 13:41:59 volumio volumio[1617]: info: CoreCommandRouter::volumioSeek Dec 13 13:41:59 volumio volumio[1617]: info: CoreStateMachine::seek Dec 13 13:41:59 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:59 volumio volumio[1617]: info: TRACKBLOCK {"uri":"mnt/USB/5A80-A105/自作自受/BEYOND - 愿我能+谁伴我闯荡+ 灰色轨迹 (Live).ogg","service":"mpd","name":"愿我能+谁伴我闯荡+ 灰色轨迹 (Live)","artist":"BEYOND","album":"歌曲合辑","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=612&web=BEYOND/%E6%AD%8C%E6%9B%B2%E5%90%88%E8%BE%91/extralarge&path=%2FUSB%2F5A80-A105%2F%E8%87%AA%E4%BD%9C%E8%87%AA%E5%8F%97&metadata=false","duration":907,"trackType":"ogg","samplerate":44.1,"bitdepth":"32 bit","channels":2} Dec 13 13:41:59 volumio volumio[1617]: info: CoreStateMachine::startPlaybackTimer Dec 13 13:41:59 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:59 volumio volumio[1617]: info: ControllerMpd::seek Dec 13 13:41:59 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:59 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:59 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:59 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:59 volumio volumio[1617]: error: null Dec 13 13:41:59 volumio volumio[1617]: info: Dec 13 13:41:59 volumio volumio[1617]: ---------------------------- MPD announces state update: player Dec 13 13:41:59 volumio volumio[1617]: info: ControllerMpd::getState Dec 13 13:41:59 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand status Dec 13 13:41:59 volumio volumio[1617]: info: sendMpdCommand status took 3 milliseconds Dec 13 13:41:59 volumio volumio[1617]: verbose: ControllerMpd::parseState Dec 13 13:41:59 volumio volumio[1617]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 13:41:59 volumio volumio[1617]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 13 13:41:59 volumio volumio[1617]: verbose: ControllerMpd::parseTrackInfo Dec 13 13:41:59 volumio volumio[1617]: info: ControllerMpd::pushState Dec 13 13:41:59 volumio volumio[1617]: info: CoreCommandRouter::servicePushState Dec 13 13:41:59 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:59 volumio volumio[1617]: verbose: STATE SERVICE {"status":"play","position":0,"seek":118000,"duration":907,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿我能+谁伴我闯荡+ 灰色轨迹 (Live)","artist":"BEYOND","album":"歌曲合辑","uri":"USB/5A80-A105/自作自受/BEYOND - 愿我能+谁伴我闯荡+ 灰色轨迹 (Live).ogg","trackType":"ogg"} Dec 13 13:41:59 volumio volumio[1617]: verbose: CURRENT POSITION 5 Dec 13 13:41:59 volumio volumio[1617]: info: CoreStateMachine::syncState stateService play Dec 13 13:41:59 volumio volumio[1617]: info: CoreStateMachine::syncState currentStatus play Dec 13 13:41:59 volumio volumio[1617]: info: Received an update from plugin. extracting info from payload Dec 13 13:41:59 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:59 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:59 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:59 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:59 volumio volumio[1617]: info: CoreStateMachine::pushState Dec 13 13:41:59 volumio volumio[1617]: info: CorePlayQueue::getTrack 5 Dec 13 13:41:59 volumio volumio[1617]: info: CoreCommandRouter::volumioPushState Dec 13 13:41:59 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 13:41:59 volumio volumio[1617]: info: ------------------------------ 66ms Dec 13 13:42:11 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 13 13:42:11 volumio volumio[1617]: info: CURURI: music-library Dec 13 13:42:13 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 13 13:42:13 volumio volumio[1617]: info: CURURI: music-library/USB Dec 13 13:42:15 volumio volumio[1617]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 13 13:42:15 volumio volumio[1617]: info: CURURI: music-library/USB/5A80-A105 Dec 13 13:42:23 volumio volumio[1617]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 13 13:42:23 volumio volumio[1617]: { Error: connect ETIMEDOUT 108.160.163.117:443 Dec 13 13:42:23 volumio volumio[1617]: at Object._errnoException (util.js:1022:11) Dec 13 13:42:23 volumio volumio[1617]: at _exceptionWithHostPort (util.js:1044:20) Dec 13 13:42:23 volumio volumio[1617]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Dec 13 13:42:23 volumio volumio[1617]: code: 'ETIMEDOUT', Dec 13 13:42:23 volumio volumio[1617]: errno: 'ETIMEDOUT', Dec 13 13:42:23 volumio volumio[1617]: syscall: 'connect', Dec 13 13:42:23 volumio volumio[1617]: address: '108.160.163.117', Dec 13 13:42:23 volumio volumio[1617]: port: 443 } Dec 13 13:42:23 volumio volumio[1617]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 13 13:42:25 volumio sudo[2109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-13 13:41 Dec 13 13:42:25 volumio sudo[2109]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e81b2037a65d8f554cb0c857a1007d659ad7f838" VOLUMIO_FE_VERSION="e489037accd8e0b2dcbd6e0b054400d8cd36d4e2" VOLUMIO_BE_VERSION="25875b197c75cd1ac7eb5664d94cdd19afb06985" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Feb 19 17:39:10 CET 2021" VOLUMIO_VERSION="2.873" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="781d4c9fbf86d562939968306a6a26f4"