-- Logs begin at Sat 2024-10-12 15:47:11 UTC, end at Sat 2026-01-10 15:21:26 UTC. -- Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 10 15:20:00 volumio volumio[1209]: info: Discovery: Getting this device information Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::volumioGetState Jan 10 15:20:00 volumio volumio[1209]: info: CorePlayQueue::getTrack 14 Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::volumioPause Jan 10 15:20:00 volumio volumio[1209]: info: CoreStateMachine::pause Jan 10 15:20:00 volumio volumio[1209]: info: CoreStateMachine::stPlaybackTimer Jan 10 15:20:00 volumio volumio[1209]: info: CoreStateMachine::servicePause Jan 10 15:20:00 volumio volumio[1209]: info: CorePlayQueue::getTrack 14 Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::servicePause Jan 10 15:20:00 volumio volumio[1209]: info: ControllerMpd::pause Jan 10 15:20:00 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand pause Jan 10 15:20:00 volumio volumio[1209]: info: Jan 10 15:20:00 volumio volumio[1209]: ---------------------------- MPD announces state update: player Jan 10 15:20:00 volumio volumio[1209]: info: ControllerMpd::getState Jan 10 15:20:00 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand status Jan 10 15:20:00 volumio volumio[1209]: verbose: ControllerMpd::parseState Jan 10 15:20:00 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 15:20:00 volumio volumio[1209]: verbose: ControllerMpd::parseTrackInfo Jan 10 15:20:00 volumio volumio[1209]: info: ControllerMpd::pushState Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::servicePushState Jan 10 15:20:00 volumio volumio[1209]: info: CorePlayQueue::getTrack 14 Jan 10 15:20:00 volumio volumio[1209]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":170887,"duration":245,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Auld Lange Syne / Bring It On Room To Me","artist":"Rebecca Pidgeon","album":"Best Voices 3","uri":"USB/Lenovo/4.Demo/Best Voices 3/15 Auld Lange Syne _ Bring It On Roo.m4a","trackType":"m4a"} Jan 10 15:20:00 volumio volumio[1209]: verbose: CURRENT POSITION 14 Jan 10 15:20:00 volumio volumio[1209]: info: CoreStateMachine::syncState stateService pause Jan 10 15:20:00 volumio volumio[1209]: info: CoreStateMachine::syncState currentStatus pause Jan 10 15:20:00 volumio volumio[1209]: info: CoreStateMachine::pushState Jan 10 15:20:00 volumio volumio[1209]: info: CorePlayQueue::getTrack 14 Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:20:00 volumio volumio[1209]: info: CoreStateMachine::stPlaybackTimer Jan 10 15:20:00 volumio volumio[1209]: info: ------------------------------ 19ms Jan 10 15:20:00 volumio volumio[1209]: info: CoreCommandRouter::volumioGetState Jan 10 15:20:00 volumio volumio[1209]: info: CorePlayQueue::getTrack 14 Jan 10 15:20:01 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 10 15:20:01 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 10 15:20:24 volumio volumio[1209]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ann%20Burton/2e0504df-c53d-4478-a1c1-45a09414c85b.jpg' Jan 10 15:20:30 volumio volumio[1209]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Antal%20Dorati%20-%20London%20Symphony%20Orchestra/2f5d4337-a6dc-46f8-bb0f-879a9108364f.jpg' Jan 10 15:20:31 volumio volumio[1209]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 15:20:31 volumio volumio[1209]: { Error: connect ETIMEDOUT 168.143.162.58:80 Jan 10 15:20:31 volumio volumio[1209]: at Object._errnoException (util.js:1022:11) Jan 10 15:20:31 volumio volumio[1209]: at _exceptionWithHostPort (util.js:1044:20) Jan 10 15:20:31 volumio volumio[1209]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 10 15:20:31 volumio volumio[1209]: code: 'ETIMEDOUT', Jan 10 15:20:31 volumio volumio[1209]: errno: 'ETIMEDOUT', Jan 10 15:20:31 volumio volumio[1209]: syscall: 'connect', Jan 10 15:20:31 volumio volumio[1209]: address: '168.143.162.58', Jan 10 15:20:31 volumio volumio[1209]: port: 80 } Jan 10 15:20:31 volumio volumio[1209]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 15:20:33 volumio sudo[767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-10 15:19 Jan 10 15:20:33 volumio sudo[767]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 15:20:33 volumio sudo[767]: pam_unix(sudo:session): session closed for user root Jan 10 15:20:36 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Jan 10 15:20:36 volumio volumio-remote-updater[727]: [2026-01-10 15:20:36] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 10 15:20:36 volumio systemd[1]: Unit volumio.service entered failed state. Jan 10 15:20:36 volumio systemd[1]: Starting dynamicswap service... Jan 10 15:20:36 volumio systemd[1]: Started dynamicswap service. Jan 10 15:20:36 volumio volumio-remote-updater[727]: [2026-01-10 15:20:36] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 10 15:20:36 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Jan 10 15:20:36 volumio systemd[1]: Starting dynamicswap service... Jan 10 15:20:36 volumio systemd[1]: Started dynamicswap service. Jan 10 15:20:36 volumio systemd[1]: Stopping Volumio Backend Module... Jan 10 15:20:36 volumio systemd[1]: Starting Volumio Backend Module... Jan 10 15:20:36 volumio systemd[1]: Started Volumio Backend Module. Jan 10 15:20:39 volumio volumio[793]: info: ------------------------------------------- Jan 10 15:20:39 volumio volumio[793]: info: ----- Volumio2 ---- Jan 10 15:20:39 volumio volumio[793]: info: ------------------------------------------- Jan 10 15:20:39 volumio volumio[793]: info: ----- System startup ---- Jan 10 15:20:39 volumio volumio[793]: info: ------------------------------------------- Jan 10 15:20:40 volumio volumio[793]: info: MYVOLUMIO Environment detected Jan 10 15:20:40 volumio volumio[793]: info: Plugin folders cleanup Jan 10 15:20:40 volumio volumio[793]: info: Scanning into folder /volumio/app/plugins/ Jan 10 15:20:40 volumio volumio[793]: info: Scanning category audio_interface Jan 10 15:20:40 volumio volumio[793]: info: Scanning category miscellanea Jan 10 15:20:40 volumio volumio[793]: info: Scanning category music_service Jan 10 15:20:40 volumio volumio[793]: info: Scanning category plugins.json Jan 10 15:20:40 volumio volumio[793]: info: Scanning category system_controller Jan 10 15:20:40 volumio volumio[793]: info: Scanning category user_interface Jan 10 15:20:40 volumio volumio[793]: info: Scanning into folder /data/plugins/ Jan 10 15:20:40 volumio volumio[793]: info: Plugin folders cleanup completed Jan 10 15:20:40 volumio volumio[793]: info: ------------------------------------------- Jan 10 15:20:40 volumio volumio[793]: info: ----- Core plugins startup ---- Jan 10 15:20:40 volumio volumio[793]: info: ------------------------------------------- Jan 10 15:20:40 volumio volumio[793]: info: Loading plugins from folder /volumio/app/plugins/ Jan 10 15:20:40 volumio volumio[793]: info: Adding plugin upnp to MyMusic Plugins Jan 10 15:20:40 volumio volumio[793]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 10 15:20:40 volumio volumio[793]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 10 15:20:40 volumio volumio[793]: info: Loading plugins from folder /data/plugins/ Jan 10 15:20:40 volumio volumio[793]: info: Loading plugin "system"... Jan 10 15:20:40 volumio volumio[793]: info: Loading plugin "appearance"... Jan 10 15:20:41 volumio volumio-remote-updater[727]: [2026-01-10 15:20:41] [connect] Successful connection Jan 10 15:20:42 volumio volumio[793]: info: Loading plugin "network"... Jan 10 15:20:42 volumio volumio[793]: info: Refreshing Cached IP Addresses Jan 10 15:20:42 volumio sudo[839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 10 15:20:42 volumio volumio[793]: info: Loading plugin "services"... Jan 10 15:20:42 volumio sudo[839]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 15:20:42 volumio volumio[793]: info: Loading plugin "alsa_controller"... Jan 10 15:20:42 volumio sudo[839]: pam_unix(sudo:session): session closed for user root Jan 10 15:20:42 volumio sudo[842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 10 15:20:42 volumio sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 15:20:42 volumio sudo[842]: pam_unix(sudo:session): session closed for user root Jan 10 15:20:42 volumio volumio[793]: info: Loading plugin "wizard"... Jan 10 15:20:42 volumio volumio[793]: info: Loading plugin "volumio_command_line_client"... Jan 10 15:20:42 volumio volumio[793]: info: Loading plugin "upnp"... Jan 10 15:20:42 volumio volumio[793]: info: [1768058442703] Starting Upmpd Daemon Jan 10 15:20:42 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 10 15:20:42 volumio volumio[793]: info: Loading plugin "my_music"... Jan 10 15:20:42 volumio volumio[793]: info: Loading plugin "mpd"... Jan 10 15:20:43 volumio volumio[793]: info: Loading plugin "upnp_browser"... Jan 10 15:20:43 volumio volumio[793]: info: Loading plugin "networkfs"... Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "alarm-clock"... Jan 10 15:20:44 volumio volumio[793]: info: Plugin airplay_emulation is not enabled Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "last_100"... Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "webradio"... Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "i2s_dacs"... Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "volumiodiscovery"... Jan 10 15:20:44 volumio volumio[793]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 10 15:20:44 volumio node[793]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 10 15:20:44 volumio volumio[793]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 10 15:20:44 volumio node[793]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 10 15:20:44 volumio volumio[793]: *** WARNING *** For more information see Jan 10 15:20:44 volumio node[793]: *** WARNING *** For more information see Jan 10 15:20:44 volumio volumio[793]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 10 15:20:44 volumio node[793]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 10 15:20:44 volumio node[793]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 10 15:20:44 volumio node[793]: *** WARNING *** For more information see Jan 10 15:20:44 volumio volumio[793]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 10 15:20:44 volumio volumio[793]: *** WARNING *** For more information see Jan 10 15:20:44 volumio volumio[793]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 10 15:20:44 volumio volumio[793]: Discovery: StartAdv! undefined Jan 10 15:20:44 volumio volumio[793]: Discovery: Started advertising... Volumio - undefined Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "outputs"... Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "albumart"... Jan 10 15:20:44 volumio volumio[793]: info: Plugin example_plugin is not enabled Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "inputs"... Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "updater_comm"... Jan 10 15:20:44 volumio volumio[793]: info: Plugin mpdemulation is not enabled Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "rest_api"... Jan 10 15:20:44 volumio volumio[793]: info: Loading plugin "websocket"... Jan 10 15:20:44 volumio volumio[793]: info: ___________ START PLUGINS ___________ Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 15:20:44 volumio volumio[793]: info: [1768058444906] CoreMusicLibrary::Adding element Media Servers Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 15:20:44 volumio volumio[793]: info: [1768058444936] CoreMusicLibrary::Adding element Last_100 Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 15:20:44 volumio volumio[793]: info: [1768058444940] CoreMusicLibrary::Adding element Webradio Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 15:20:44 volumio volumio[793]: info: ------------------------------------------- Jan 10 15:20:44 volumio volumio[793]: info: ----- MyVolumio plugins startup ---- Jan 10 15:20:44 volumio volumio[793]: info: ------------------------------------------- Jan 10 15:20:44 volumio volumio[793]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 10 15:20:44 volumio volumio[793]: Forking 3 albumart workers Jan 10 15:20:44 volumio volumio[793]: info: Loading i18n strings for locale zh Jan 10 15:20:44 volumio volumio[793]: Updating browse sources language Jan 10 15:20:44 volumio volumio[793]: Cannot find translation for sourceMedia Servers Jan 10 15:20:44 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::initPlayerControls Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 15:20:45 volumio volumio[793]: info: BOOT COMPLETED Jan 10 15:20:45 volumio volumio[793]: [Metrics] CommandRouter: 5s 814.78ms Jan 10 15:20:45 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 15:20:45 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Jan 10 15:20:45 volumio volumio[793]: Starting albumart workers Jan 10 15:20:45 volumio volumio[793]: Starting albumart workers Jan 10 15:20:45 volumio volumio[793]: Starting albumart workers Jan 10 15:20:50 volumio volumio[793]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 10 15:20:50 volumio volumio[793]: info: CoreCommandRouter::Close All Modals sent Jan 10 15:20:50 volumio volumio[793]: info: CoreCommandRouter::Close All Modals sent Jan 10 15:20:50 volumio volumio[793]: Express server listening on port 3000 Jan 10 15:20:50 volumio volumio[793]: [Metrics] WebUI: 12s 163.09ms Jan 10 15:20:50 volumio volumio[793]: Volumio Calling Home Jan 10 15:20:50 volumio volumio[793]: info: CoreStateMachine::resetVolumioState Jan 10 15:20:50 volumio volumio[793]: info: CoreStateMachine::getcurrentVolume Jan 10 15:20:50 volumio volumio[793]: info: CoreCommandRouter::volumioRetrievevolume Jan 10 15:20:50 volumio volumio[793]: info: CoreStateMachine::pushState Jan 10 15:20:50 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Jan 10 15:20:50 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Jan 10 15:20:50 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:20:50 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 15:20:50 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 15:20:50 volumio volumio[793]: info: Setting Device type: Raspberry PI Jan 10 15:20:50 volumio volumio[793]: info: MPD running with PID1397 Jan 10 15:20:50 volumio volumio[793]: ,establishing connection Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::volumioGetState Jan 10 15:20:51 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 10 15:20:51 volumio volumio[793]: info: Reloading queue from file Jan 10 15:20:51 volumio volumio[793]: info: CoreStateMachine::setRepeat true single undefined Jan 10 15:20:51 volumio volumio[793]: info: CoreStateMachine::pushState Jan 10 15:20:51 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:20:51 volumio volumio[793]: info: CoreStateMachine::setRandom false Jan 10 15:20:51 volumio volumio[793]: info: CoreStateMachine::pushState Jan 10 15:20:51 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::volumioGetState Jan 10 15:20:51 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 10 15:20:51 volumio volumio[793]: info: Listing playlists Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::volumioGetVisibleSources Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::volumioGetQueue Jan 10 15:20:51 volumio volumio[793]: info: CoreStateMachine::getQueue Jan 10 15:20:51 volumio volumio[793]: info: CorePlayQueue::getQueue Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 10 15:20:51 volumio volumio[793]: Discovery: adding ca56ecb6-5934-421c-b552-a193d4b9bddc Jan 10 15:20:51 volumio volumio[793]: info: mDNS: Found device Volumio Jan 10 15:20:51 volumio volumio[793]: info: CoreCommandRouter::volumioGetState Jan 10 15:20:51 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Jan 10 15:20:52 volumio volumio[793]: Discovery: this is already registered, ca56ecb6-5934-421c-b552-a193d4b9bddc Jan 10 15:20:52 volumio volumio[793]: info: mDNS: Found device Volumio Jan 10 15:20:52 volumio volumio[793]: info: CoreCommandRouter::volumioGetState Jan 10 15:20:52 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Jan 10 15:20:52 volumio volumio[793]: info: CoreCommandRouter::volumioGetState Jan 10 15:20:52 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Jan 10 15:20:52 volumio sudo[938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 10 15:20:52 volumio sudo[938]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 15:20:52 volumio sudo[938]: pam_unix(sudo:session): session closed for user root Jan 10 15:20:52 volumio sudo[941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 10 15:20:52 volumio sudo[941]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 15:20:52 volumio sudo[941]: pam_unix(sudo:session): session closed for user root Jan 10 15:20:52 volumio sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 10 15:20:52 volumio sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 15:20:52 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 10 15:20:52 volumio sudo[951]: pam_unix(sudo:session): session closed for user root Jan 10 15:20:52 volumio volumio[793]: info: Upmpdcli Daemon Started Jan 10 15:20:53 volumio volumio-remote-updater[727]: [2026-01-10 15:20:53] [connect] Successful connection Jan 10 15:20:54 volumio volumio-remote-updater[727]: [2026-01-10 15:20:54] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1768058453 101 Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 10 15:20:55 volumio volumio[793]: info: Adding plugin bluetooth to MyMusic Plugins Jan 10 15:20:55 volumio volumio[793]: info: Adding plugin cd_controller to MyMusic Plugins Jan 10 15:20:55 volumio volumio[793]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 10 15:20:55 volumio volumio[793]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 10 15:20:58 volumio volumio[793]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 10 15:21:00 volumio volumio[793]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 10 15:21:00 volumio volumio[793]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 10 15:21:00 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 15:21:00 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 15:21:00 volumio volumio[793]: info: Starting MyVolumio Remote Streaming Endpoints Jan 10 15:21:00 volumio volumio[793]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 10 15:21:00 volumio volumio[793]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 10 15:21:00 volumio volumio[793]: info: Streaming services startup Jan 10 15:21:00 volumio volumio[793]: info: Starting Streaming Daemon Jan 10 15:21:00 volumio volumio[793]: info: MyVolumio not started Jan 10 15:21:00 volumio volumio[793]: info: Initializing device activation check Jan 10 15:21:00 volumio sudo[972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 10 15:21:00 volumio sudo[972]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 15:21:00 volumio systemd[1]: Stopping Volumio Streaming Daemon... Jan 10 15:21:00 volumio volumio[793]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 10 15:21:00 volumio systemd[1]: Starting Volumio Streaming Daemon... Jan 10 15:21:00 volumio systemd[1]: Started Volumio Streaming Daemon. Jan 10 15:21:00 volumio sudo[972]: pam_unix(sudo:session): session closed for user root Jan 10 15:21:00 volumio volumio-streaming-daemon[978]: ############################ Jan 10 15:21:00 volumio volumio-streaming-daemon[978]: # Volumio Streaming Daemon # Jan 10 15:21:00 volumio volumio-streaming-daemon[978]: # Running on port 7777 # Jan 10 15:21:00 volumio volumio-streaming-daemon[978]: ############################ Jan 10 15:21:00 volumio volumio-streaming-daemon[978]: Environment: production Jan 10 15:21:01 volumio volumio[793]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=f507dfabb2d58c7adf310f61ec4c9948" http://updates.volumio.org:7070/downloader-v1/track-device Jan 10 15:21:01 volumio volumio[793]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 10 15:21:01 volumio volumio[793]: Dload Upload Total Spent Left Speed Jan 10 15:21:01 volumio volumio[793]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 10 15:21:01 volumio volumio[793]: retrying in 5 seconds, trial 0 Jan 10 15:21:01 volumio volumio[793]: Volumio Calling Home Jan 10 15:21:11 volumio volumio-streaming-daemon[978]: Environment: production Jan 10 15:21:18 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 15:21:18 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 15:21:18 volumio volumio[793]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=f507dfabb2d58c7adf310f61ec4c9948" http://updates.volumio.org:7070/downloader-v1/track-device Jan 10 15:21:18 volumio volumio[793]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 10 15:21:18 volumio volumio[793]: Dload Upload Total Spent Left Speed Jan 10 15:21:18 volumio volumio[793]: [235B blob data] Jan 10 15:21:18 volumio volumio[793]: retrying in 5 seconds, trial 1 Jan 10 15:21:18 volumio volumio[793]: Volumio Calling Home Jan 10 15:21:20 volumio volumio[793]: info: Fetching Streaming Services browse cache Jan 10 15:21:24 volumio volumio[793]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Jan 10 15:21:24 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:21:24 volumio volumio[793]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Jan 10 15:21:24 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:21:25 volumio volumio[793]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 15:21:25 volumio volumio[793]: { Error: connect ETIMEDOUT 74.86.12.173:80 Jan 10 15:21:25 volumio volumio[793]: at Object._errnoException (util.js:1022:11) Jan 10 15:21:25 volumio volumio[793]: at _exceptionWithHostPort (util.js:1044:20) Jan 10 15:21:25 volumio volumio[793]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 10 15:21:25 volumio volumio[793]: code: 'ETIMEDOUT', Jan 10 15:21:25 volumio volumio[793]: errno: 'ETIMEDOUT', Jan 10 15:21:25 volumio volumio[793]: syscall: 'connect', Jan 10 15:21:25 volumio volumio[793]: address: '74.86.12.173', Jan 10 15:21:25 volumio volumio[793]: port: 80 } Jan 10 15:21:25 volumio volumio[793]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 15:21:26 volumio sudo[1016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-10 15:20 Jan 10 15:21:26 volumio sudo[1016]: 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="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"