-- Logs begin at Tue 2025-09-09 10:13:32 UTC, end at Tue 2025-09-09 10:16:57 UTC. -- Sep 09 10:15:53 volumio systemd[1]: Time has been changed Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "network"... Sep 09 10:15:56 volumio volumio[927]: info: Refreshing Cached IP Addresses Sep 09 10:15:56 volumio sudo[965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "services"... Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "alsa_controller"... Sep 09 10:15:56 volumio sudo[965]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:15:56 volumio sudo[965]: pam_unix(sudo:session): session closed for user root Sep 09 10:15:56 volumio sudo[968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 09 10:15:56 volumio sudo[968]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:15:56 volumio sudo[968]: pam_unix(sudo:session): session closed for user root Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "wizard"... Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "volumio_command_line_client"... Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "upnp"... Sep 09 10:15:56 volumio volumio[927]: info: [1757412956434] Starting Upmpd Daemon Sep 09 10:15:56 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "my_music"... Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "mpd"... Sep 09 10:15:56 volumio volumio[927]: info: Loading plugin "upnp_browser"... Sep 09 10:15:57 volumio volumio[927]: info: Loading plugin "networkfs"... Sep 09 10:15:57 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 09 10:15:57 volumio volumio[927]: info: Loading plugin "alarm-clock"... Sep 09 10:15:57 volumio sudo[991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=yy,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.12/music /mnt/NAS/music Sep 09 10:15:57 volumio sudo[991]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:15:57 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching Sep 09 10:15:57 volumio kernel: Key type cifs.spnego registered Sep 09 10:15:57 volumio kernel: Key type cifs.idmap registered Sep 09 10:15:57 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Sep 09 10:15:57 volumio volumio[927]: info: Loading plugin "airplay_emulation"... Sep 09 10:15:57 volumio volumio[927]: info: Starting Shairport Sync Sep 09 10:15:57 volumio volumio[927]: info: Loading plugin "last_100"... Sep 09 10:15:57 volumio volumio[927]: info: Loading plugin "webradio"... Sep 09 10:15:58 volumio sudo[991]: pam_unix(sudo:session): session closed for user root Sep 09 10:15:58 volumio volumio[927]: info: Loading plugin "i2s_dacs"... Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: Loading plugin "volumiodiscovery"... Sep 09 10:15:58 volumio volumio[927]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 09 10:15:58 volumio node[927]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 09 10:15:58 volumio node[927]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 09 10:15:58 volumio node[927]: *** WARNING *** For more information see Sep 09 10:15:58 volumio node[927]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 09 10:15:58 volumio node[927]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 09 10:15:58 volumio node[927]: *** WARNING *** For more information see Sep 09 10:15:58 volumio volumio[927]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 09 10:15:58 volumio volumio[927]: *** WARNING *** For more information see Sep 09 10:15:58 volumio volumio[927]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 09 10:15:58 volumio volumio[927]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 09 10:15:58 volumio volumio[927]: *** WARNING *** For more information see Sep 09 10:15:58 volumio volumio[927]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 09 10:15:58 volumio volumio[927]: Discovery: StartAdv! undefined Sep 09 10:15:58 volumio volumio[927]: Discovery: Started advertising... Volumio - undefined Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 09 10:15:58 volumio volumio[927]: info: Loading plugin "outputs"... Sep 09 10:15:58 volumio volumio[927]: info: Loading plugin "albumart"... Sep 09 10:15:58 volumio volumio[927]: info: Plugin example_plugin is not enabled Sep 09 10:15:58 volumio volumio[927]: info: Loading plugin "inputs"... Sep 09 10:15:58 volumio volumio[927]: info: Loading plugin "updater_comm"... Sep 09 10:15:58 volumio volumio[927]: info: Plugin mpdemulation is not enabled Sep 09 10:15:58 volumio volumio[927]: info: Loading plugin "rest_api"... Sep 09 10:15:58 volumio volumio[927]: info: Loading plugin "websocket"... Sep 09 10:15:58 volumio volumio[927]: info: ___________ START PLUGINS ___________ Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 09 10:15:58 volumio volumio[927]: info: [1757412958474] CoreMusicLibrary::Adding element Media Servers Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 10:15:58 volumio volumio[927]: Forking 3 albumart workers Sep 09 10:15:58 volumio volumio[927]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 09 10:15:58 volumio volumio[927]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 09 10:15:58 volumio volumio[927]: info: [1757412958605] CoreMusicLibrary::Adding element Last_100 Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 09 10:15:58 volumio volumio[927]: info: [1757412958610] CoreMusicLibrary::Adding element Webradio Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 09 10:15:58 volumio volumio[927]: info: ------------------------------------------- Sep 09 10:15:58 volumio volumio[927]: info: ----- MyVolumio plugins startup ---- Sep 09 10:15:58 volumio volumio[927]: info: ------------------------------------------- Sep 09 10:15:58 volumio volumio[927]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 09 10:15:58 volumio volumio[927]: info: Loading i18n strings for locale zh Sep 09 10:15:58 volumio volumio[927]: Updating browse sources language Sep 09 10:15:58 volumio volumio[927]: Cannot find translation for sourceMedia Servers Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::initPlayerControls Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 09 10:15:58 volumio volumio[927]: info: BOOT COMPLETED Sep 09 10:15:58 volumio volumio[927]: [Metrics] CommandRouter: 6s 336.15ms Sep 09 10:15:58 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 09 10:15:59 volumio volumio[927]: Starting albumart workers Sep 09 10:15:59 volumio volumio[927]: Starting albumart workers Sep 09 10:15:59 volumio volumio[927]: Starting albumart workers Sep 09 10:16:04 volumio volumio[927]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::Close All Modals sent Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::Close All Modals sent Sep 09 10:16:04 volumio volumio[927]: Express server listening on port 3000 Sep 09 10:16:04 volumio volumio[927]: [Metrics] WebUI: 12s 295.46ms Sep 09 10:16:04 volumio volumio[927]: Volumio Calling Home Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::resetVolumioState Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::getcurrentVolume Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::volumioRetrievevolume Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 09 10:16:04 volumio volumio[927]: info: Setting Device type: Raspberry PI Sep 09 10:16:04 volumio volumio[927]: info: MPD running with PID703 Sep 09 10:16:04 volumio volumio[927]: ,establishing connection Sep 09 10:16:04 volumio volumio-remote-updater[666]: [2025-09-09 10:16:04] [connect] Successful connection Sep 09 10:16:04 volumio volumio[927]: info: VolumeController:: Volume=100 Mute =true Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::pushState Sep 09 10:16:04 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::volumioPushState Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::updateTrackBlock Sep 09 10:16:04 volumio volumio[927]: info: CorePlayQueue::getTrackBlock Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::volumioRetrievevolume Sep 09 10:16:04 volumio volumio[927]: info: Reloading queue from file Sep 09 10:16:04 volumio volumio[927]: error: updateQueue error: null Sep 09 10:16:04 volumio volumio[927]: error: Failed LSINFO: Error: [50@0] {} No such directory Sep 09 10:16:04 volumio volumio-remote-updater[666]: [2025-09-09 10:16:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1757412964 101 Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::setRepeat false single undefined Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::pushState Sep 09 10:16:04 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::volumioPushState Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::setRandom null Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::pushState Sep 09 10:16:04 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::volumioPushState Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 10:16:04 volumio volumio[927]: info: Volumio called home Sep 09 10:16:04 volumio volumio[927]: info: Starting Shairport Sync Sep 09 10:16:04 volumio volumio[927]: info: Starting Shairport Sync Sep 09 10:16:04 volumio sudo[1111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 09 10:16:04 volumio sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 09 10:16:04 volumio sudo[1111]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:16:04 volumio sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:16:04 volumio volumio[927]: info: VolumeController:: Volume=100 Mute =true Sep 09 10:16:04 volumio volumio[927]: info: CoreStateMachine::pushState Sep 09 10:16:04 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::volumioPushState Sep 09 10:16:04 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 10:16:04 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Sep 09 10:16:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 09 10:16:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 09 10:16:04 volumio sudo[1111]: pam_unix(sudo:session): session closed for user root Sep 09 10:16:04 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Sep 09 10:16:04 volumio sudo[1113]: pam_unix(sudo:session): session closed for user root Sep 09 10:16:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 09 10:16:05 volumio volumio[927]: Discovery: adding c2517517-ca7f-47c9-9e0b-a514526e405a Sep 09 10:16:05 volumio volumio[927]: info: mDNS: Found device Volumio Sep 09 10:16:05 volumio volumio[927]: info: CoreCommandRouter::volumioGetState Sep 09 10:16:05 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:05 volumio volumio[927]: info: Shairport-Sync Started Sep 09 10:16:05 volumio volumio[927]: Error adding Membership: Error: addMembership EINVAL Sep 09 10:16:05 volumio volumio[927]: info: Shairport-Sync Started Sep 09 10:16:05 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 09 10:16:05 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 09 10:16:05 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 09 10:16:05 volumio volumio[927]: info: CoreCommandRouter::volumioGetState Sep 09 10:16:05 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:06 volumio sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 09 10:16:06 volumio sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:16:06 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 09 10:16:06 volumio sudo[1141]: pam_unix(sudo:session): session closed for user root Sep 09 10:16:06 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:16:06 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Sep 09 10:16:06 volumio sudo[1159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 09 10:16:06 volumio sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:16:06 volumio sudo[1159]: pam_unix(sudo:session): session closed for user root Sep 09 10:16:06 volumio sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 09 10:16:06 volumio sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:16:06 volumio sudo[1162]: pam_unix(sudo:session): session closed for user root Sep 09 10:16:06 volumio sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 09 10:16:06 volumio sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:16:06 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Sep 09 10:16:06 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 09 10:16:06 volumio sudo[1177]: pam_unix(sudo:session): session closed for user root Sep 09 10:16:06 volumio volumio[927]: info: Upmpdcli Daemon Started Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::volumioGetVisibleSources Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::volumioGetState Sep 09 10:16:07 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::volumioGetQueue Sep 09 10:16:07 volumio volumio[927]: info: CoreStateMachine::getQueue Sep 09 10:16:07 volumio volumio[927]: info: CorePlayQueue::getQueue Sep 09 10:16:07 volumio volumio[927]: info: Listing playlists Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 09 10:16:07 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 09 10:16:08 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 10:16:08 volumio volumio[927]: info: CURURI: music-library Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 09 10:16:08 volumio volumio[927]: info: Adding plugin bluetooth to MyMusic Plugins Sep 09 10:16:08 volumio volumio[927]: info: Adding plugin cd_controller to MyMusic Plugins Sep 09 10:16:08 volumio volumio[927]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 09 10:16:08 volumio volumio[927]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 09 10:16:08 volumio volumio[927]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 09 10:16:09 volumio volumio[927]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 09 10:16:09 volumio volumio[927]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 09 10:16:09 volumio volumio[927]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 09 10:16:09 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 09 10:16:09 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 09 10:16:09 volumio volumio[927]: info: Starting MyVolumio Remote Streaming Endpoints Sep 09 10:16:09 volumio volumio[927]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 09 10:16:09 volumio volumio[927]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 09 10:16:09 volumio volumio[927]: info: Streaming services startup Sep 09 10:16:09 volumio volumio[927]: info: Starting Streaming Daemon Sep 09 10:16:09 volumio sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 09 10:16:09 volumio sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 09 10:16:09 volumio volumio[927]: info: MyVolumio not started Sep 09 10:16:09 volumio volumio[927]: info: Initializing device activation check Sep 09 10:16:09 volumio systemd[1]: Stopping Volumio Streaming Daemon... Sep 09 10:16:09 volumio systemd[1]: Starting Volumio Streaming Daemon... Sep 09 10:16:09 volumio volumio[927]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 09 10:16:09 volumio systemd[1]: Started Volumio Streaming Daemon. Sep 09 10:16:09 volumio sudo[1208]: pam_unix(sudo:session): session closed for user root Sep 09 10:16:09 volumio volumio-streaming-daemon[1218]: ############################ Sep 09 10:16:09 volumio volumio-streaming-daemon[1218]: # Volumio Streaming Daemon # Sep 09 10:16:09 volumio volumio-streaming-daemon[1218]: # Running on port 7777 # Sep 09 10:16:09 volumio volumio-streaming-daemon[1218]: ############################ Sep 09 10:16:09 volumio volumio-streaming-daemon[1218]: Environment: production Sep 09 10:16:09 volumio volumio[927]: info: CoreCommandRouter::volumioGetVisibleSources Sep 09 10:16:09 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 09 10:16:09 volumio volumio[927]: info: CoreCommandRouter::volumioGetState Sep 09 10:16:09 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:09 volumio volumio[927]: info: CoreCommandRouter::volumioGetQueue Sep 09 10:16:09 volumio volumio[927]: info: CoreStateMachine::getQueue Sep 09 10:16:09 volumio volumio[927]: info: CorePlayQueue::getQueue Sep 09 10:16:09 volumio volumio[927]: info: Listing playlists Sep 09 10:16:09 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 09 10:16:09 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 10:16:09 volumio volumio[927]: info: CURURI: music-library/NAS Sep 09 10:16:10 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 10:16:10 volumio volumio[927]: info: CURURI: music-library/NAS/music Sep 09 10:16:10 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 10:16:10 volumio volumio[927]: info: CURURI: music-library/NAS/music/1、流行曲 Sep 09 10:16:12 volumio volumio-streaming-daemon[1218]: Environment: production Sep 09 10:16:12 volumio volumio[927]: info: Fetching Streaming Services browse cache Sep 09 10:16:17 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 09 10:16:17 volumio volumio[927]: info: CURURI: albums:// Sep 09 10:16:17 volumio volumio[927]: listAlbums - loading Albums from cache Sep 09 10:16:24 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 09 10:16:28 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 09 10:16:28 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 09 10:16:32 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 09 10:16:33 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::ClearQueue Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::stop Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 10:16:35 volumio volumio[927]: UNSET VOLATILE Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::clearPlayQueue Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::saveQueue Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::volumioPushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::volumioPushQueue Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::addQueueItems Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::addQueueItems Sep 09 10:16:35 volumio volumio[927]: info: Adding Item to queue: http://satellitepull.cnr.cn/live/wxgdyyzs/playlist.m3u8 Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::saveQueue Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::volumioPushQueue Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::updateTrackBlock Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::getTrackBlock Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::volumioPlay Sep 09 10:16:35 volumio volumio[927]: UNSET VOLATILE Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::play index 0 Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::stop Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 10:16:35 volumio volumio[927]: UNSET VOLATILE Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::play index undefined Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::startPlaybackTimer Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:35 volumio volumio[927]: info: [1757412995571] ControllerWebradio::clearAddPlayTrack Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 10:16:35 volumio volumio[927]: info: sendMpdCommand stop took 14 milliseconds Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 10:16:35 volumio volumio[927]: info: Sep 09 10:16:35 volumio volumio[927]: ---------------------------- MPD announces system playlist update Sep 09 10:16:35 volumio volumio[927]: info: Ignoring MPD Status Update Sep 09 10:16:35 volumio volumio[927]: info: sendMpdCommand clear took 55 milliseconds Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::sendMpdCommand load "http://satellitepull.cnr.cn/live/wxgdyyzs/playlist.m3u8" Sep 09 10:16:35 volumio volumio[927]: error: updateQueue error: null Sep 09 10:16:35 volumio volumio[927]: info: ------------------------------ 41ms Sep 09 10:16:35 volumio volumio[927]: info: Sep 09 10:16:35 volumio volumio[927]: ---------------------------- MPD announces system playlist update Sep 09 10:16:35 volumio volumio[927]: info: Ignoring MPD Status Update Sep 09 10:16:35 volumio volumio[927]: info: sendMpdCommand load "http://satellitepull.cnr.cn/live/wxgdyyzs/playlist.m3u8" took 122 milliseconds Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::sendMpdCommand play Sep 09 10:16:35 volumio volumio[927]: info: ------------------------------ 66ms Sep 09 10:16:35 volumio volumio[927]: info: sendMpdCommand play took 64 milliseconds Sep 09 10:16:35 volumio volumio[927]: info: Sep 09 10:16:35 volumio volumio[927]: ---------------------------- MPD announces state update: player Sep 09 10:16:35 volumio volumio[927]: info: ControllerMpd::getState Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::sendMpdCommand status Sep 09 10:16:35 volumio volumio[927]: info: Sep 09 10:16:35 volumio volumio[927]: ---------------------------- MPD announces state update: player Sep 09 10:16:35 volumio volumio[927]: info: ControllerMpd::getState Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::sendMpdCommand status Sep 09 10:16:35 volumio volumio[927]: info: sendMpdCommand status took 8 milliseconds Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::parseState Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 10:16:35 volumio volumio[927]: info: sendMpdCommand status took 11 milliseconds Sep 09 10:16:35 volumio volumio[927]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::parseState Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::parseTrackInfo Sep 09 10:16:35 volumio volumio[927]: info: ControllerMpd::pushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::servicePushState Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:35 volumio volumio[927]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"184 Kbps","isStreaming":false,"title":"playlist.m3u8?wsSession=430594912b39f4ec485cc26b-175741299576498&wsIPSercert=9675d0876b936e768afe8a7e35ce367f&wsiphost=local&wsBindIP=1","artist":null,"album":null,"uri":"http://59.37.82.162/satellitepull.cnr.cn/live/wxgdyyzs/playlist.m3u8?wsSession=430594912b39f4ec485cc26b-175741299576498&wsIPSercert=9675d0876b936e768afe8a7e35ce367f&wsiphost=local&wsBindIP=1","trackType":""} Sep 09 10:16:35 volumio volumio[927]: verbose: CURRENT POSITION 0 Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::syncState stateService play Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::syncState currentStatus stop Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::pushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::volumioPushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 10:16:35 volumio volumio[927]: info: ------------------------------ 43ms Sep 09 10:16:35 volumio volumio[927]: info: sendMpdCommand playlistinfo took 43 milliseconds Sep 09 10:16:35 volumio volumio[927]: verbose: ControllerMpd::parseTrackInfo Sep 09 10:16:35 volumio volumio[927]: info: ControllerMpd::pushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::servicePushState Sep 09 10:16:35 volumio volumio[927]: info: CorePlayQueue::getTrack 0 Sep 09 10:16:35 volumio volumio[927]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"184 Kbps","isStreaming":false,"title":"playlist.m3u8?wsSession=430594912b39f4ec485cc26b-175741299576498&wsIPSercert=9675d0876b936e768afe8a7e35ce367f&wsiphost=local&wsBindIP=1","artist":null,"album":null,"uri":"http://59.37.82.162/satellitepull.cnr.cn/live/wxgdyyzs/playlist.m3u8?wsSession=430594912b39f4ec485cc26b-175741299576498&wsIPSercert=9675d0876b936e768afe8a7e35ce367f&wsiphost=local&wsBindIP=1","trackType":""} Sep 09 10:16:35 volumio volumio[927]: verbose: CURRENT POSITION 0 Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::syncState stateService play Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::syncState currentStatus play Sep 09 10:16:35 volumio volumio[927]: info: Received an update from plugin. extracting info from payload Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::pushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::volumioPushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 10:16:35 volumio volumio[927]: info: CoreStateMachine::pushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::volumioPushState Sep 09 10:16:35 volumio volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 10:16:35 volumio volumio[927]: info: ------------------------------ 75ms Sep 09 10:16:57 volumio volumio[927]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 10:16:57 volumio volumio[927]: { Error: connect ETIMEDOUT 210.56.51.193:443 Sep 09 10:16:57 volumio volumio[927]: at Object._errnoException (util.js:1022:11) Sep 09 10:16:57 volumio volumio[927]: at _exceptionWithHostPort (util.js:1044:20) Sep 09 10:16:57 volumio volumio[927]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Sep 09 10:16:57 volumio volumio[927]: code: 'ETIMEDOUT', Sep 09 10:16:57 volumio volumio[927]: errno: 'ETIMEDOUT', Sep 09 10:16:57 volumio volumio[927]: syscall: 'connect', Sep 09 10:16:57 volumio volumio[927]: address: '210.56.51.193', Sep 09 10:16:57 volumio volumio[927]: port: 443 } Sep 09 10:16:57 volumio volumio[927]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 10:16:57 volumio sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-09 10:15 Sep 09 10:16:57 volumio sudo[1354]: 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="537e3f50b5a8aa9bdf42f94adc80b348609b5c47" VOLUMIO_BE_VERSION="d7e6c614214d5dc616fddcbcfefc47e1990da7b1" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 8 12:10:14 CEST 2021" VOLUMIO_VERSION="2.909" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="3aea8955ace41c92b011ae3a243c3f0d"