-- Logs begin at Tue 2020-12-22 13:39:52 UTC, end at Wed 2025-05-28 13:47:39 UTC. -- May 28 13:46:00 volumio volumio[9869]: info: ------------------------------------------- May 28 13:46:00 volumio volumio[9869]: info: ----- Volumio2 ---- May 28 13:46:00 volumio volumio[9869]: info: ------------------------------------------- May 28 13:46:00 volumio volumio[9869]: info: ----- System startup ---- May 28 13:46:00 volumio volumio[9869]: info: ------------------------------------------- May 28 13:46:01 volumio volumio[9869]: info: MYVOLUMIO Environment detected May 28 13:46:01 volumio volumio[9869]: info: Plugin folders cleanup May 28 13:46:01 volumio volumio[9869]: info: Scanning into folder /volumio/app/plugins/ May 28 13:46:01 volumio volumio[9869]: info: Scanning category audio_interface May 28 13:46:01 volumio volumio[9869]: info: Scanning category miscellanea May 28 13:46:01 volumio volumio[9869]: info: Scanning category music_service May 28 13:46:01 volumio volumio[9869]: info: Scanning category plugins.json May 28 13:46:01 volumio volumio[9869]: info: Scanning category system_controller May 28 13:46:01 volumio volumio[9869]: info: Scanning category user_interface May 28 13:46:01 volumio volumio[9869]: info: Scanning into folder /data/plugins/ May 28 13:46:01 volumio volumio[9869]: info: Plugin folders cleanup completed May 28 13:46:01 volumio volumio[9869]: info: ------------------------------------------- May 28 13:46:01 volumio volumio[9869]: info: ----- Core plugins startup ---- May 28 13:46:01 volumio volumio[9869]: info: ------------------------------------------- May 28 13:46:01 volumio volumio[9869]: info: Loading plugins from folder /volumio/app/plugins/ May 28 13:46:01 volumio volumio[9869]: info: Adding plugin upnp to MyMusic Plugins May 28 13:46:01 volumio volumio[9869]: info: Adding plugin airplay_emulation to MyMusic Plugins May 28 13:46:01 volumio volumio[9869]: info: Adding plugin upnp_browser to MyMusic Plugins May 28 13:46:01 volumio volumio[9869]: info: Loading plugins from folder /data/plugins/ May 28 13:46:01 volumio volumio[9869]: info: Loading plugin "system"... May 28 13:46:01 volumio volumio[9869]: info: Loading plugin "appearance"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "network"... May 28 13:46:02 volumio volumio[9869]: info: Refreshing Cached IP Addresses May 28 13:46:02 volumio sudo[9896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "services"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "alsa_controller"... May 28 13:46:02 volumio sudo[9896]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:02 volumio sudo[9899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 13:46:02 volumio sudo[9896]: pam_unix(sudo:session): session closed for user root May 28 13:46:02 volumio sudo[9899]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:02 volumio sudo[9899]: pam_unix(sudo:session): session closed for user root May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "wizard"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "volumio_command_line_client"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "upnp"... May 28 13:46:02 volumio volumio[9869]: info: [1748439962177] Starting Upmpd Daemon May 28 13:46:02 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "my_music"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "mpd"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "upnp_browser"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "networkfs"... May 28 13:46:02 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "alarm-clock"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "airplay_emulation"... May 28 13:46:02 volumio volumio[9869]: info: Starting Shairport Sync May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "last_100"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "webradio"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "i2s_dacs"... May 28 13:46:02 volumio volumio[9869]: info: I2S DAC not set, start Auto-detection May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "volumiodiscovery"... May 28 13:46:02 volumio volumio[9869]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 28 13:46:02 volumio node[9869]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 28 13:46:02 volumio node[9869]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 13:46:02 volumio node[9869]: *** WARNING *** For more information see May 28 13:46:02 volumio node[9869]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 28 13:46:02 volumio node[9869]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 13:46:02 volumio node[9869]: *** WARNING *** For more information see May 28 13:46:02 volumio volumio[9869]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 13:46:02 volumio volumio[9869]: *** WARNING *** For more information see May 28 13:46:02 volumio volumio[9869]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 28 13:46:02 volumio volumio[9869]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 13:46:02 volumio volumio[9869]: *** WARNING *** For more information see May 28 13:46:02 volumio volumio[9869]: info: Applying required configuration parameters for plugin volumiodiscovery May 28 13:46:02 volumio volumio[9869]: Discovery: StartAdv! undefined May 28 13:46:02 volumio volumio[9869]: Discovery: Started advertising... Volumio - undefined May 28 13:46:02 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "outputs"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "albumart"... May 28 13:46:02 volumio volumio[9869]: info: Plugin example_plugin is not enabled May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "inputs"... May 28 13:46:02 volumio volumio[9869]: info: Loading plugin "updater_comm"... May 28 13:46:03 volumio volumio[9869]: info: Plugin mpdemulation is not enabled May 28 13:46:03 volumio volumio[9869]: info: Loading plugin "rest_api"... May 28 13:46:03 volumio volumio[9869]: info: Loading plugin "websocket"... May 28 13:46:03 volumio volumio[9869]: info: ___________ START PLUGINS ___________ May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 28 13:46:03 volumio volumio[9869]: info: [1748439963154] CoreMusicLibrary::Adding element Media Servers May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:03 volumio volumio[9869]: Forking 3 albumart workers May 28 13:46:03 volumio volumio[9869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 28 13:46:03 volumio volumio[9869]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 28 13:46:03 volumio volumio[9869]: info: [1748439963246] CoreMusicLibrary::Adding element Last_100 May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 28 13:46:03 volumio volumio[9869]: info: [1748439963250] CoreMusicLibrary::Adding element Webradio May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 28 13:46:03 volumio volumio[9869]: info: ------------------------------------------- May 28 13:46:03 volumio volumio[9869]: info: ----- MyVolumio plugins startup ---- May 28 13:46:03 volumio volumio[9869]: info: ------------------------------------------- May 28 13:46:03 volumio volumio[9869]: info: [MyVolumio PluginManager] Fetching plans data.... May 28 13:46:03 volumio volumio[9869]: info: Loading i18n strings for locale zh May 28 13:46:03 volumio volumio[9869]: Updating browse sources language May 28 13:46:03 volumio volumio[9869]: Cannot find translation for sourceMedia Servers May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::initPlayerControls May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: BOOT COMPLETED May 28 13:46:03 volumio volumio[9869]: [Metrics] CommandRouter: 2s 505.80ms May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:46:03 volumio volumio[9869]: aplay: main:722: audio open error: Device or resource busy May 28 13:46:03 volumio volumio[9869]: Cannot play startup sound May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::Close All Modals sent May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::Close All Modals sent May 28 13:46:03 volumio volumio[9869]: Express server listening on port 3000 May 28 13:46:03 volumio volumio[9869]: [Metrics] WebUI: 2s 840.55ms May 28 13:46:03 volumio volumio[9869]: Volumio Calling Home May 28 13:46:03 volumio volumio[9869]: info: CoreStateMachine::resetVolumioState May 28 13:46:03 volumio volumio[9869]: info: CoreStateMachine::getcurrentVolume May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::volumioRetrievevolume May 28 13:46:03 volumio volumio[9869]: info: CoreStateMachine::pushState May 28 13:46:03 volumio volumio[9869]: info: CorePlayQueue::getTrack 0 May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::volumioPushState May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 13:46:03 volumio volumio[9869]: info: Setting Device type: Raspberry PI May 28 13:46:03 volumio volumio[9869]: info: MPD running with PID657 May 28 13:46:03 volumio volumio[9869]: ,establishing connection May 28 13:46:03 volumio sudo[9981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 May 28 13:46:03 volumio sudo[9981]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:03 volumio sudo[9981]: pam_unix(sudo:session): session closed for user root May 28 13:46:03 volumio volumio[9869]: info: Reloading queue from file May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:46:03 volumio volumio[9869]: info: CoreStateMachine::setRepeat true single undefined May 28 13:46:03 volumio volumio[9869]: info: CoreStateMachine::pushState May 28 13:46:03 volumio volumio[9869]: info: CorePlayQueue::getTrack 0 May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::volumioPushState May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 13:46:03 volumio volumio[9869]: info: CoreStateMachine::setRandom false May 28 13:46:03 volumio volumio[9869]: info: CoreStateMachine::pushState May 28 13:46:03 volumio volumio[9869]: info: CorePlayQueue::getTrack 0 May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::volumioPushState May 28 13:46:03 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 13:46:03 volumio volumio[9869]: Starting albumart workers May 28 13:46:03 volumio volumio[9869]: info: Starting Shairport Sync May 28 13:46:03 volumio volumio[9869]: Starting albumart workers May 28 13:46:03 volumio volumio[9869]: Starting albumart workers May 28 13:46:03 volumio volumio[9869]: info: Starting Shairport Sync May 28 13:46:03 volumio sudo[9992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 28 13:46:03 volumio sudo[9990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 28 13:46:03 volumio sudo[9992]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:03 volumio sudo[9990]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 28 13:46:04 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 28 13:46:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 28 13:46:04 volumio sudo[9990]: pam_unix(sudo:session): session closed for user root May 28 13:46:04 volumio sudo[9992]: pam_unix(sudo:session): session closed for user root May 28 13:46:04 volumio volumio[9869]: info: Shairport-Sync Started May 28 13:46:04 volumio volumio[9869]: Error adding Membership: Error: addMembership EINVAL May 28 13:46:04 volumio volumio[9869]: Discovery: adding 86852ca6-6f5e-47e7-8e86-51d731bee84d May 28 13:46:04 volumio volumio[9869]: info: mDNS: Found device Volumio May 28 13:46:04 volumio volumio[9869]: info: CoreCommandRouter::volumioGetState May 28 13:46:04 volumio volumio[9869]: info: CorePlayQueue::getTrack 0 May 28 13:46:04 volumio volumio[9869]: info: Shairport-Sync Started May 28 13:46:04 volumio volumio-remote-updater[596]: [2025-05-28 13:46:04] [connect] Successful connection May 28 13:46:04 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 28 13:46:04 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 13:46:04 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 28 13:46:05 volumio volumio-remote-updater[596]: [2025-05-28 13:46:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1748439964 101 May 28 13:46:08 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:46:08 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:10 volumio volumio[9869]: info: CoreCommandRouter::volumioGetState May 28 13:46:10 volumio volumio[9869]: info: CorePlayQueue::getTrack 0 May 28 13:46:10 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mascagni/e481c386-f0d5-4aed-86de-60f7538745d4.jpg' May 28 13:46:10 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Maucha%20Adnet/af7a1892-f748-4cff-b1b7-7f539b7ac83d.jpg' May 28 13:46:11 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Maurice%20Ravel/1c43c2cb-4c45-46ba-a1f5-755c527c07cb.jpg' May 28 13:46:11 volumio volumio[9869]: info: CoreCommandRouter::volumioGetState May 28 13:46:11 volumio volumio[9869]: info: CorePlayQueue::getTrack 0 May 28 13:46:11 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 28 13:46:11 volumio volumio[9869]: info: CoreCommandRouter::volumioGetVisibleSources May 28 13:46:11 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:11 volumio volumio[9869]: info: Listing playlists May 28 13:46:11 volumio volumio[9869]: info: CoreCommandRouter::volumioGetQueue May 28 13:46:11 volumio volumio[9869]: info: CoreStateMachine::getQueue May 28 13:46:11 volumio volumio[9869]: info: CorePlayQueue::getQueue May 28 13:46:12 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Maurizio%20Pollini/68cf5bc1-cb1d-4636-8939-50d307154d9b.jpg' May 28 13:46:12 volumio sudo[10056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 13:46:12 volumio sudo[10056]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:12 volumio sudo[10056]: pam_unix(sudo:session): session closed for user root May 28 13:46:12 volumio sudo[10059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 13:46:12 volumio sudo[10059]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:12 volumio sudo[10059]: pam_unix(sudo:session): session closed for user root May 28 13:46:12 volumio sudo[10068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 28 13:46:12 volumio sudo[10068]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:12 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 28 13:46:12 volumio sudo[10068]: pam_unix(sudo:session): session closed for user root May 28 13:46:12 volumio volumio[9869]: info: Upmpdcli Daemon Started May 28 13:46:12 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Maurizio%20Pollini%20(Piano)/b299debc-f855-4a6c-8391-8d8a4f50b1af.jpg' May 28 13:46:14 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Max%20Reger/0db2e15e-cff4-498e-a63c-a95f82543292.jpg' May 28 13:46:14 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Meav/23d8828b-5191-4b89-bce2-bfe09427014f.jpg' May 28 13:46:14 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Meili/ef00460e-7192-4c19-b796-0a32c2bd860a.jpg' May 28 13:46:15 volumio volumio[9869]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=ba3a74d1f56eb408bbb1bd461f527a4a" http://updates.volumio.org:7070/downloader-v1/track-device May 28 13:46:15 volumio volumio[9869]: % Total % Received % Xferd Average Speed Time Time Time Current May 28 13:46:15 volumio volumio[9869]: Dload Upload Total Spent Left Speed May 28 13:46:15 volumio volumio[9869]: [235B blob data] May 28 13:46:15 volumio volumio[9869]: retrying in 5 seconds, trial 0 May 28 13:46:15 volumio volumio[9869]: Volumio Calling Home May 28 13:46:18 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mendelssohn/7628f188-6db1-48bc-9b31-1bb76c379101.jpg' May 28 13:46:23 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Michael%20Garson/e327056e-a614-4961-8220-7eeb07e04438.jpg' May 28 13:46:24 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Michael%20Kr%C3%BCcker/67a1259f-96e1-4f9b-9ba9-ab8275386dc5.jpg' May 28 13:46:26 volumio volumio[9869]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=ba3a74d1f56eb408bbb1bd461f527a4a" http://updates.volumio.org:7070/downloader-v1/track-device May 28 13:46:26 volumio volumio[9869]: % Total % Received % Xferd Average Speed Time Time Time Current May 28 13:46:26 volumio volumio[9869]: Dload Upload Total Spent Left Speed May 28 13:46:26 volumio volumio[9869]: [235B blob data] May 28 13:46:26 volumio volumio[9869]: retrying in 5 seconds, trial 1 May 28 13:46:26 volumio volumio[9869]: Volumio Calling Home May 28 13:46:27 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Michael%20Tilson%20Thomas/3663d487-ab70-4ece-bbee-e43ebeb56005.jpg' May 28 13:46:28 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Michala%20Petri/c3489fdd-0479-4bd6-b985-c48c28af85ba.jpg' May 28 13:46:33 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 28 13:46:33 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 28 13:46:35 volumio volumio[9869]: info: Adding plugin bluetooth to MyMusic Plugins May 28 13:46:35 volumio volumio[9869]: info: Adding plugin cd_controller to MyMusic Plugins May 28 13:46:35 volumio volumio[9869]: info: Adding plugin smart_inputs to MyMusic Plugins May 28 13:46:35 volumio volumio[9869]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 28 13:46:36 volumio volumio[9869]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 28 13:46:36 volumio volumio[9869]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 28 13:46:36 volumio volumio[9869]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 28 13:46:36 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:46:36 volumio volumio[9869]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:46:36 volumio volumio[9869]: info: Starting MyVolumio Remote Streaming Endpoints May 28 13:46:36 volumio volumio[9869]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 28 13:46:36 volumio volumio[9869]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 28 13:46:36 volumio volumio[9869]: info: Streaming services startup May 28 13:46:36 volumio volumio[9869]: info: Starting Streaming Daemon May 28 13:46:36 volumio sudo[10139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 28 13:46:36 volumio sudo[10139]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:36 volumio systemd[1]: Stopping Volumio Streaming Daemon... May 28 13:46:36 volumio systemd[1]: Starting Volumio Streaming Daemon... May 28 13:46:36 volumio systemd[1]: Started Volumio Streaming Daemon. May 28 13:46:36 volumio sudo[10139]: pam_unix(sudo:session): session closed for user root May 28 13:46:36 volumio volumio[9869]: info: MyVolumio not started May 28 13:46:36 volumio volumio[9869]: info: Initializing device activation check May 28 13:46:36 volumio volumio-streaming-daemon[10149]: ############################ May 28 13:46:36 volumio volumio-streaming-daemon[10149]: # Volumio Streaming Daemon # May 28 13:46:36 volumio volumio-streaming-daemon[10149]: # Running on port 7777 # May 28 13:46:36 volumio volumio-streaming-daemon[10149]: ############################ May 28 13:46:36 volumio volumio-streaming-daemon[10149]: Environment: production May 28 13:46:36 volumio volumio[9869]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 28 13:46:36 volumio volumio[9869]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=ba3a74d1f56eb408bbb1bd461f527a4a" http://updates.volumio.org:7070/downloader-v1/track-device May 28 13:46:36 volumio volumio[9869]: % Total % Received % Xferd Average Speed Time Time Time Current May 28 13:46:36 volumio volumio[9869]: Dload Upload Total Spent Left Speed May 28 13:46:36 volumio volumio[9869]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 28 13:46:36 volumio volumio[9869]: retrying in 5 seconds, trial 2 May 28 13:46:36 volumio volumio[9869]: Volumio Calling Home May 28 13:46:39 volumio volumio-streaming-daemon[10149]: Environment: production May 28 13:46:39 volumio volumio[9869]: info: Fetching Streaming Services browse cache May 28 13:46:42 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mick%20West/1376edfd-fd50-4461-95b8-f6dacf980ca5.jpg' May 28 13:46:43 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mike%20Garson/5c87df88-d254-4f5a-8321-597b6b305d7d.jpg' May 28 13:46:44 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mike%20Silver/2ed17550-704a-46e5-bf0d-7af6787398b0.jpg' May 28 13:46:44 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mikhail%20Ivanovich%20Glinka/841042bc-8eeb-469a-abf0-ba8b95bc23db.jpg' May 28 13:46:44 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mikhail%20Pletnev/8452585f-6593-461e-aa43-bbd2de9a1a86.jpg' May 28 13:46:44 volumio volumio[9869]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Miles%20Davis/87e95008-6fde-4c8c-a01b-965bcef24a6b.jpg' May 28 13:46:50 volumio volumio[9869]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 13:46:50 volumio volumio[9869]: { Error: connect ETIMEDOUT 185.60.219.41:80 May 28 13:46:50 volumio volumio[9869]: at Object._errnoException (util.js:1022:11) May 28 13:46:50 volumio volumio[9869]: at _exceptionWithHostPort (util.js:1044:20) May 28 13:46:50 volumio volumio[9869]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 28 13:46:50 volumio volumio[9869]: code: 'ETIMEDOUT', May 28 13:46:50 volumio volumio[9869]: errno: 'ETIMEDOUT', May 28 13:46:50 volumio volumio[9869]: syscall: 'connect', May 28 13:46:50 volumio volumio[9869]: address: '185.60.219.41', May 28 13:46:50 volumio volumio[9869]: port: 80 } May 28 13:46:50 volumio volumio[9869]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 13:46:50 volumio sudo[10199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 13:45 May 28 13:46:50 volumio sudo[10199]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:50 volumio sudo[10199]: pam_unix(sudo:session): session closed for user root May 28 13:46:52 volumio volumio-remote-updater[596]: [2025-05-28 13:46:52] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 28 13:46:52 volumio volumio-remote-updater[596]: [2025-05-28 13:46:52] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 28 13:46:52 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE May 28 13:46:52 volumio systemd[1]: Unit volumio.service entered failed state. May 28 13:46:52 volumio systemd[1]: Starting dynamicswap service... May 28 13:46:52 volumio systemd[1]: Started dynamicswap service. May 28 13:46:52 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. May 28 13:46:52 volumio systemd[1]: Starting dynamicswap service... May 28 13:46:52 volumio systemd[1]: Started dynamicswap service. May 28 13:46:52 volumio systemd[1]: Stopping Volumio Backend Module... May 28 13:46:52 volumio systemd[1]: Starting Volumio Backend Module... May 28 13:46:52 volumio systemd[1]: Started Volumio Backend Module. May 28 13:46:53 volumio volumio[10223]: info: ------------------------------------------- May 28 13:46:53 volumio volumio[10223]: info: ----- Volumio2 ---- May 28 13:46:53 volumio volumio[10223]: info: ------------------------------------------- May 28 13:46:53 volumio volumio[10223]: info: ----- System startup ---- May 28 13:46:53 volumio volumio[10223]: info: ------------------------------------------- May 28 13:46:53 volumio volumio[10223]: info: MYVOLUMIO Environment detected May 28 13:46:53 volumio volumio[10223]: info: Plugin folders cleanup May 28 13:46:53 volumio volumio[10223]: info: Scanning into folder /volumio/app/plugins/ May 28 13:46:53 volumio volumio[10223]: info: Scanning category audio_interface May 28 13:46:53 volumio volumio[10223]: info: Scanning category miscellanea May 28 13:46:53 volumio volumio[10223]: info: Scanning category music_service May 28 13:46:53 volumio volumio[10223]: info: Scanning category plugins.json May 28 13:46:53 volumio volumio[10223]: info: Scanning category system_controller May 28 13:46:53 volumio volumio[10223]: info: Scanning category user_interface May 28 13:46:53 volumio volumio[10223]: info: Scanning into folder /data/plugins/ May 28 13:46:53 volumio volumio[10223]: info: Plugin folders cleanup completed May 28 13:46:53 volumio volumio[10223]: info: ------------------------------------------- May 28 13:46:53 volumio volumio[10223]: info: ----- Core plugins startup ---- May 28 13:46:53 volumio volumio[10223]: info: ------------------------------------------- May 28 13:46:53 volumio volumio[10223]: info: Loading plugins from folder /volumio/app/plugins/ May 28 13:46:53 volumio volumio[10223]: info: Adding plugin upnp to MyMusic Plugins May 28 13:46:53 volumio volumio[10223]: info: Adding plugin airplay_emulation to MyMusic Plugins May 28 13:46:53 volumio volumio[10223]: info: Adding plugin upnp_browser to MyMusic Plugins May 28 13:46:53 volumio volumio[10223]: info: Loading plugins from folder /data/plugins/ May 28 13:46:53 volumio volumio[10223]: info: Loading plugin "system"... May 28 13:46:53 volumio volumio[10223]: info: Loading plugin "appearance"... May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "network"... May 28 13:46:54 volumio volumio[10223]: info: Refreshing Cached IP Addresses May 28 13:46:54 volumio sudo[10248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "services"... May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "alsa_controller"... May 28 13:46:54 volumio sudo[10248]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:54 volumio sudo[10248]: pam_unix(sudo:session): session closed for user root May 28 13:46:54 volumio sudo[10251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 13:46:54 volumio sudo[10251]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:54 volumio sudo[10251]: pam_unix(sudo:session): session closed for user root May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "wizard"... May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "volumio_command_line_client"... May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "upnp"... May 28 13:46:54 volumio volumio[10223]: info: [1748440014753] Starting Upmpd Daemon May 28 13:46:54 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "my_music"... May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "mpd"... May 28 13:46:54 volumio volumio[10223]: info: Loading plugin "upnp_browser"... May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "networkfs"... May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "alarm-clock"... May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "airplay_emulation"... May 28 13:46:55 volumio volumio[10223]: info: Starting Shairport Sync May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "last_100"... May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "webradio"... May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "i2s_dacs"... May 28 13:46:55 volumio volumio[10223]: info: I2S DAC not set, start Auto-detection May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "volumiodiscovery"... May 28 13:46:55 volumio volumio[10223]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 28 13:46:55 volumio node[10223]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 28 13:46:55 volumio node[10223]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 13:46:55 volumio node[10223]: *** WARNING *** For more information see May 28 13:46:55 volumio node[10223]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 28 13:46:55 volumio node[10223]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 13:46:55 volumio node[10223]: *** WARNING *** For more information see May 28 13:46:55 volumio volumio[10223]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 13:46:55 volumio volumio[10223]: *** WARNING *** For more information see May 28 13:46:55 volumio volumio[10223]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 28 13:46:55 volumio volumio[10223]: *** WARNING *** Please fix your application to use the native API of Avahi! May 28 13:46:55 volumio volumio[10223]: *** WARNING *** For more information see May 28 13:46:55 volumio volumio[10223]: info: Applying required configuration parameters for plugin volumiodiscovery May 28 13:46:55 volumio volumio[10223]: Discovery: StartAdv! undefined May 28 13:46:55 volumio volumio[10223]: Discovery: Started advertising... Volumio - undefined May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "outputs"... May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "albumart"... May 28 13:46:55 volumio volumio[10223]: info: Plugin example_plugin is not enabled May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "inputs"... May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "updater_comm"... May 28 13:46:55 volumio volumio[10223]: info: Plugin mpdemulation is not enabled May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "rest_api"... May 28 13:46:55 volumio volumio[10223]: info: Loading plugin "websocket"... May 28 13:46:55 volumio volumio[10223]: info: ___________ START PLUGINS ___________ May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 28 13:46:55 volumio volumio[10223]: info: [1748440015674] CoreMusicLibrary::Adding element Media Servers May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:55 volumio volumio[10223]: Forking 3 albumart workers May 28 13:46:55 volumio volumio[10223]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 28 13:46:55 volumio volumio[10223]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 28 13:46:55 volumio volumio[10223]: info: [1748440015772] CoreMusicLibrary::Adding element Last_100 May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 28 13:46:55 volumio volumio[10223]: info: [1748440015775] CoreMusicLibrary::Adding element Webradio May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 28 13:46:55 volumio volumio[10223]: info: ------------------------------------------- May 28 13:46:55 volumio volumio[10223]: info: ----- MyVolumio plugins startup ---- May 28 13:46:55 volumio volumio[10223]: info: ------------------------------------------- May 28 13:46:55 volumio volumio[10223]: info: [MyVolumio PluginManager] Fetching plans data.... May 28 13:46:55 volumio volumio[10223]: info: Loading i18n strings for locale zh May 28 13:46:55 volumio volumio[10223]: Updating browse sources language May 28 13:46:55 volumio volumio[10223]: Cannot find translation for sourceMedia Servers May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::initPlayerControls May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 28 13:46:55 volumio volumio[10223]: info: BOOT COMPLETED May 28 13:46:55 volumio volumio[10223]: [Metrics] CommandRouter: 2s 358.69ms May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:46:55 volumio volumio[10223]: aplay: main:722: audio open error: Device or resource busy May 28 13:46:55 volumio volumio[10223]: Cannot play startup sound May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::Close All Modals sent May 28 13:46:55 volumio volumio[10223]: info: CoreCommandRouter::Close All Modals sent May 28 13:46:55 volumio volumio[10223]: Express server listening on port 3000 May 28 13:46:55 volumio volumio[10223]: [Metrics] WebUI: 2s 676.67ms May 28 13:46:55 volumio volumio[10223]: Volumio Calling Home May 28 13:46:56 volumio volumio[10223]: info: CoreStateMachine::resetVolumioState May 28 13:46:56 volumio volumio[10223]: info: CoreStateMachine::getcurrentVolume May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::volumioRetrievevolume May 28 13:46:56 volumio volumio[10223]: info: CoreStateMachine::pushState May 28 13:46:56 volumio volumio[10223]: info: CorePlayQueue::getTrack 0 May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::volumioPushState May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 13:46:56 volumio volumio[10223]: info: Setting Device type: Raspberry PI May 28 13:46:56 volumio volumio[10223]: info: MPD running with PID657 May 28 13:46:56 volumio volumio[10223]: ,establishing connection May 28 13:46:56 volumio sudo[10316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 May 28 13:46:56 volumio sudo[10316]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:56 volumio sudo[10316]: pam_unix(sudo:session): session closed for user root May 28 13:46:56 volumio volumio[10223]: Starting albumart workers May 28 13:46:56 volumio volumio[10223]: Starting albumart workers May 28 13:46:56 volumio volumio[10223]: info: Reloading queue from file May 28 13:46:56 volumio volumio[10223]: Starting albumart workers May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:46:56 volumio volumio[10223]: info: CoreStateMachine::setRepeat true single undefined May 28 13:46:56 volumio volumio[10223]: info: CoreStateMachine::pushState May 28 13:46:56 volumio volumio[10223]: info: CorePlayQueue::getTrack 0 May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::volumioPushState May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 13:46:56 volumio volumio[10223]: info: CoreStateMachine::setRandom false May 28 13:46:56 volumio volumio[10223]: info: CoreStateMachine::pushState May 28 13:46:56 volumio volumio[10223]: info: CorePlayQueue::getTrack 0 May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::volumioPushState May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::volumioGetState May 28 13:46:56 volumio volumio[10223]: info: CorePlayQueue::getTrack 0 May 28 13:46:56 volumio volumio[10223]: info: Starting Shairport Sync May 28 13:46:56 volumio volumio[10223]: info: Starting Shairport Sync May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::volumioGetVisibleSources May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 13:46:56 volumio volumio[10223]: info: Listing playlists May 28 13:46:56 volumio sudo[10326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::volumioGetQueue May 28 13:46:56 volumio volumio[10223]: info: CoreStateMachine::getQueue May 28 13:46:56 volumio volumio[10223]: info: CorePlayQueue::getQueue May 28 13:46:56 volumio sudo[10326]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:56 volumio sudo[10329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 28 13:46:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 28 13:46:56 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 28 13:46:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 28 13:46:56 volumio sudo[10329]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:46:56 volumio sudo[10326]: pam_unix(sudo:session): session closed for user root May 28 13:46:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 28 13:46:56 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 28 13:46:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 28 13:46:56 volumio sudo[10329]: pam_unix(sudo:session): session closed for user root May 28 13:46:56 volumio volumio[10223]: Discovery: adding 86852ca6-6f5e-47e7-8e86-51d731bee84d May 28 13:46:56 volumio volumio[10223]: info: mDNS: Found device Volumio May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::volumioGetState May 28 13:46:56 volumio volumio[10223]: info: CorePlayQueue::getTrack 0 May 28 13:46:56 volumio volumio[10223]: info: Shairport-Sync Started May 28 13:46:56 volumio volumio[10223]: Error adding Membership: Error: addMembership EINVAL May 28 13:46:56 volumio volumio[10223]: info: Shairport-Sync Started May 28 13:46:56 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 28 13:46:57 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 28 13:46:57 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 28 13:46:57 volumio volumio-remote-updater[596]: [2025-05-28 13:46:57] [connect] Successful connection May 28 13:46:57 volumio volumio-remote-updater[596]: [2025-05-28 13:46:57] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1748440017 101 May 28 13:47:01 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:47:01 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 13:47:01 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Modest%20Petrovich%20Mussorgsky/9a3fabbd-48b9-4d15-8ed1-15d13c250f70.jpg' May 28 13:47:02 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Moore/c47d486f-0c0b-4325-a896-09fd626b88ff.jpg' May 28 13:47:03 volumio volumio[10223]: info: CoreCommandRouter::volumioGetState May 28 13:47:03 volumio volumio[10223]: info: CorePlayQueue::getTrack 0 May 28 13:47:03 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Morley/0cde3b0e-f770-4462-af06-d49fc67ffd71.jpg' May 28 13:47:03 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Moura%20Lympany/12c93c2a-8929-49a2-b22f-00ad74a453b5.jpg' May 28 13:47:03 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Moussorgsky/2ad92a19-513f-4d75-9d20-c3cb8b3b012d.jpg' May 28 13:47:04 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mozart/b7864796-e277-466e-a40d-38df4f0aa27a.jpg' May 28 13:47:04 volumio sudo[10410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 13:47:04 volumio sudo[10410]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:47:04 volumio sudo[10410]: pam_unix(sudo:session): session closed for user root May 28 13:47:04 volumio sudo[10412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 13:47:04 volumio sudo[10412]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:47:04 volumio sudo[10412]: pam_unix(sudo:session): session closed for user root May 28 13:47:04 volumio sudo[10424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 28 13:47:04 volumio sudo[10424]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:47:04 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 28 13:47:04 volumio sudo[10424]: pam_unix(sudo:session): session closed for user root May 28 13:47:04 volumio volumio[10223]: info: Upmpdcli Daemon Started May 28 13:47:06 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mozart%2C%20Wolfgang%20Amadeus/a0838b9c-e979-43af-87cf-3b1f8b07ea4b.jpg' May 28 13:47:06 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mozart%2C%20Wolfgang%20Amadeus%20(1756-1791)/925b1586-85cc-49e4-b676-c254be4562b8.jpg' May 28 13:47:06 volumio volumio[10223]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=ba3a74d1f56eb408bbb1bd461f527a4a" http://updates.volumio.org:7070/downloader-v1/track-device May 28 13:47:06 volumio volumio[10223]: % Total % Received % Xferd Average Speed Time Time Time Current May 28 13:47:06 volumio volumio[10223]: Dload Upload Total Spent Left Speed May 28 13:47:06 volumio volumio[10223]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 28 13:47:06 volumio volumio[10223]: retrying in 5 seconds, trial 0 May 28 13:47:06 volumio volumio[10223]: Volumio Calling Home May 28 13:47:06 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mstislav%20Rostropovich/0209a991-0c43-404a-96a3-8b0c87c1f814.jpg' May 28 13:47:06 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mstislav%20Rostropovich%20(Cello)/48529672-a8f8-4994-90f1-178473279554.jpg' May 28 13:47:06 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mstislav%20Rostropovich%2C%20Sviatoslav%20Richter/f7ed56f0-804d-43bb-b54a-b52be92e5a4f.jpg' May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 28 13:47:12 volumio volumio[10223]: info: Adding plugin bluetooth to MyMusic Plugins May 28 13:47:12 volumio volumio[10223]: info: Adding plugin cd_controller to MyMusic Plugins May 28 13:47:12 volumio volumio[10223]: info: Adding plugin smart_inputs to MyMusic Plugins May 28 13:47:12 volumio volumio[10223]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 28 13:47:13 volumio volumio[10223]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 28 13:47:14 volumio volumio[10223]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 28 13:47:14 volumio volumio[10223]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 28 13:47:14 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:47:14 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:47:14 volumio volumio[10223]: info: Starting MyVolumio Remote Streaming Endpoints May 28 13:47:14 volumio volumio[10223]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 28 13:47:14 volumio volumio[10223]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 28 13:47:14 volumio volumio[10223]: info: Streaming services startup May 28 13:47:14 volumio volumio[10223]: info: Starting Streaming Daemon May 28 13:47:14 volumio sudo[10458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 28 13:47:14 volumio sudo[10458]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:47:14 volumio systemd[1]: Stopping Volumio Streaming Daemon... May 28 13:47:14 volumio systemd[1]: Starting Volumio Streaming Daemon... May 28 13:47:14 volumio systemd[1]: Started Volumio Streaming Daemon. May 28 13:47:14 volumio sudo[10458]: pam_unix(sudo:session): session closed for user root May 28 13:47:14 volumio volumio[10223]: info: MyVolumio not started May 28 13:47:14 volumio volumio[10223]: info: Initializing device activation check May 28 13:47:14 volumio volumio-streaming-daemon[10468]: ############################ May 28 13:47:14 volumio volumio-streaming-daemon[10468]: # Volumio Streaming Daemon # May 28 13:47:14 volumio volumio-streaming-daemon[10468]: # Running on port 7777 # May 28 13:47:14 volumio volumio-streaming-daemon[10468]: ############################ May 28 13:47:14 volumio volumio-streaming-daemon[10468]: Environment: production May 28 13:47:14 volumio volumio[10223]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 28 13:47:14 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Murray%20Perahia/de8b22b1-f612-4b62-819b-bc0283093b23.jpg' May 28 13:47:14 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mussorgsky/1a56239f-9a5c-4625-90c5-cd60b8319d5c.jpg' May 28 13:47:16 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Narciso%20Yepes%20(Guitar)/15a3d58e-804c-4029-b7c6-e86de35b1b61.jpg' May 28 13:47:16 volumio volumio[10223]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=ba3a74d1f56eb408bbb1bd461f527a4a" http://updates.volumio.org:7070/downloader-v1/track-device May 28 13:47:16 volumio volumio[10223]: % Total % Received % Xferd Average Speed Time Time Time Current May 28 13:47:16 volumio volumio[10223]: Dload Upload Total Spent Left Speed May 28 13:47:16 volumio volumio[10223]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 28 13:47:16 volumio volumio[10223]: retrying in 5 seconds, trial 1 May 28 13:47:16 volumio volumio[10223]: Volumio Calling Home May 28 13:47:16 volumio volumio-streaming-daemon[10468]: Environment: production May 28 13:47:16 volumio volumio[10223]: info: Fetching Streaming Services browse cache May 28 13:47:16 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Natalie%20Dessay/f5fb3b30-fc40-4a11-adf2-8ca8019cdffa.jpg' May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 28 13:47:18 volumio volumio[10223]: info: Adding plugin bluetooth to MyMusic Plugins May 28 13:47:18 volumio volumio[10223]: info: Adding plugin cd_controller to MyMusic Plugins May 28 13:47:18 volumio volumio[10223]: info: Adding plugin smart_inputs to MyMusic Plugins May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 28 13:47:18 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:47:18 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:47:18 volumio volumio[10223]: info: Starting MyVolumio Remote Streaming Endpoints May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 28 13:47:18 volumio volumio[10223]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 28 13:47:18 volumio volumio[10223]: info: Streaming services startup May 28 13:47:18 volumio volumio[10223]: info: Starting Streaming Daemon May 28 13:47:18 volumio sudo[10493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 28 13:47:18 volumio sudo[10493]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 13:47:18 volumio systemd[1]: Stopping Volumio Streaming Daemon... May 28 13:47:18 volumio systemd[1]: Starting Volumio Streaming Daemon... May 28 13:47:18 volumio systemd[1]: Started Volumio Streaming Daemon. May 28 13:47:18 volumio sudo[10493]: pam_unix(sudo:session): session closed for user root May 28 13:47:18 volumio volumio-streaming-daemon[10503]: ############################ May 28 13:47:18 volumio volumio-streaming-daemon[10503]: # Volumio Streaming Daemon # May 28 13:47:18 volumio volumio-streaming-daemon[10503]: # Running on port 7777 # May 28 13:47:18 volumio volumio-streaming-daemon[10503]: ############################ May 28 13:47:18 volumio volumio-streaming-daemon[10503]: Environment: production May 28 13:47:19 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nathan%20Milstein%20(Violin)/dc18f9f5-bd10-421d-8980-4276467c2c0b.jpg' May 28 13:47:20 volumio volumio-streaming-daemon[10503]: Environment: production May 28 13:47:20 volumio volumio[10223]: info: Fetching Streaming Services browse cache May 28 13:47:23 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/New%20York%20Trio/e272911e-400d-4dc5-a3ee-8496d394e026.jpg' May 28 13:47:23 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nicanor%20Zabaleta%20(Harp)/c939dc26-8b1c-47f9-b403-6f5c5f4fe94e.jpg' May 28 13:47:24 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nicki%20Parrott/0eb65472-f436-4eb9-8c3a-08593a246c5f.jpg' May 28 13:47:25 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 28 13:47:25 volumio volumio[10223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 13:47:25 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nicolai%20Rimsky-Korsakov/ff98fe2a-ccdb-43e5-888c-8f9490ab31df.jpg' May 28 13:47:26 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nielsen/c6631db6-eb7a-47b9-9744-8dc2b8faae22.jpg' May 28 13:47:27 volumio volumio[10223]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=ba3a74d1f56eb408bbb1bd461f527a4a" http://updates.volumio.org:7070/downloader-v1/track-device May 28 13:47:27 volumio volumio[10223]: % Total % Received % Xferd Average Speed Time Time Time Current May 28 13:47:27 volumio volumio[10223]: Dload Upload Total Spent Left Speed May 28 13:47:27 volumio volumio[10223]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 28 13:47:27 volumio volumio[10223]: retrying in 5 seconds, trial 2 May 28 13:47:27 volumio volumio[10223]: Volumio Calling Home May 28 13:47:28 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nikolai%20Rimsky%20Korsakov/7c10371a-491f-4ea4-85f4-8df1f339e847.jpg' May 28 13:47:28 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nikolai%20Rimsky-Korsakov/37ce506b-04da-4b32-995e-b0e529e88f33.jpg' May 28 13:47:32 volumio volumio[10223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Norah%20Jones/5cf0e068-3da3-4d6b-af7d-d874392a145f.jpg' May 28 13:47:38 volumio volumio[10223]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 13:47:38 volumio volumio[10223]: { Error: connect ETIMEDOUT 128.242.245.29:80 May 28 13:47:38 volumio volumio[10223]: at Object._errnoException (util.js:1022:11) May 28 13:47:38 volumio volumio[10223]: at _exceptionWithHostPort (util.js:1044:20) May 28 13:47:38 volumio volumio[10223]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 28 13:47:38 volumio volumio[10223]: code: 'ETIMEDOUT', May 28 13:47:38 volumio volumio[10223]: errno: 'ETIMEDOUT', May 28 13:47:38 volumio volumio[10223]: syscall: 'connect', May 28 13:47:38 volumio volumio[10223]: address: '128.242.245.29', May 28 13:47:38 volumio volumio[10223]: port: 80 } May 28 13:47:38 volumio volumio[10223]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 13:47:39 volumio sudo[10568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 13:46 May 28 13:47:39 volumio sudo[10568]: 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="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 14:39:52 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="097e28ee6263e31d0bf6b690a02dcab3"