-- Logs begin at Thu 2020-04-30 06:10:22 UTC, end at Sat 2025-03-01 05:05:28 UTC. -- Mar 01 05:04:00 volumio volumio[1733]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=8c4a9229368b83ee982bbfbc6c9cc7ba" http://updates.volumio.org:7070/downloader-v1/track-device Mar 01 05:04:00 volumio volumio[1733]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 01 05:04:00 volumio volumio[1733]: Dload Upload Total Spent Left Speed Mar 01 05:04:00 volumio volumio[1733]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 01 05:04:00 volumio volumio[1733]: retrying in 5 seconds, trial 1 Mar 01 05:04:00 volumio volumio[1733]: Volumio Calling Home Mar 01 05:04:09 volumio volumio[1733]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 05:04:09 volumio volumio[1733]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:04:11 volumio volumio[1733]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=8c4a9229368b83ee982bbfbc6c9cc7ba" http://updates.volumio.org:7070/downloader-v1/track-device Mar 01 05:04:11 volumio volumio[1733]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 01 05:04:11 volumio volumio[1733]: Dload Upload Total Spent Left Speed Mar 01 05:04:11 volumio volumio[1733]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 01 05:04:11 volumio volumio[1733]: retrying in 5 seconds, trial 2 Mar 01 05:04:11 volumio volumio[1733]: Volumio Calling Home Mar 01 05:04:14 volumio volumio[1733]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 05:04:14 volumio volumio[1733]: { Error: connect ETIMEDOUT 31.13.70.9:443 Mar 01 05:04:14 volumio volumio[1733]: at Object._errnoException (util.js:1022:11) Mar 01 05:04:14 volumio volumio[1733]: at _exceptionWithHostPort (util.js:1044:20) Mar 01 05:04:14 volumio volumio[1733]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 01 05:04:14 volumio volumio[1733]: code: 'ETIMEDOUT', Mar 01 05:04:14 volumio volumio[1733]: errno: 'ETIMEDOUT', Mar 01 05:04:14 volumio volumio[1733]: syscall: 'connect', Mar 01 05:04:14 volumio volumio[1733]: address: '31.13.70.9', Mar 01 05:04:14 volumio volumio[1733]: port: 443 } Mar 01 05:04:14 volumio volumio[1733]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 05:04:14 volumio sudo[2091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 05:03 Mar 01 05:04:14 volumio sudo[2091]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:14 volumio sudo[2091]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:14 volumio volumio-remote-updater[622]: [2025-03-01 05:04:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 01 05:04:14 volumio volumio-remote-updater[622]: [2025-03-01 05:04:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 01 05:04:14 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Mar 01 05:04:14 volumio systemd[1]: Unit volumio.service entered failed state. Mar 01 05:04:14 volumio systemd[1]: Starting dynamicswap service... Mar 01 05:04:14 volumio systemd[1]: Started dynamicswap service. Mar 01 05:04:14 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Mar 01 05:04:14 volumio systemd[1]: Starting dynamicswap service... Mar 01 05:04:14 volumio systemd[1]: Started dynamicswap service. Mar 01 05:04:14 volumio systemd[1]: Stopping Volumio Backend Module... Mar 01 05:04:14 volumio systemd[1]: Starting Volumio Backend Module... Mar 01 05:04:14 volumio systemd[1]: Started Volumio Backend Module. Mar 01 05:04:15 volumio volumio[2112]: info: ------------------------------------------- Mar 01 05:04:15 volumio volumio[2112]: info: ----- Volumio2 ---- Mar 01 05:04:15 volumio volumio[2112]: info: ------------------------------------------- Mar 01 05:04:15 volumio volumio[2112]: info: ----- System startup ---- Mar 01 05:04:15 volumio volumio[2112]: info: ------------------------------------------- Mar 01 05:04:15 volumio volumio[2112]: info: MYVOLUMIO Environment detected Mar 01 05:04:16 volumio volumio[2112]: info: Plugin folders cleanup Mar 01 05:04:16 volumio volumio[2112]: info: Scanning into folder /volumio/app/plugins/ Mar 01 05:04:16 volumio volumio[2112]: info: Scanning category audio_interface Mar 01 05:04:16 volumio volumio[2112]: info: Scanning category miscellanea Mar 01 05:04:16 volumio volumio[2112]: info: Scanning category music_service Mar 01 05:04:16 volumio volumio[2112]: info: Scanning category plugins.json Mar 01 05:04:16 volumio volumio[2112]: info: Scanning category system_controller Mar 01 05:04:16 volumio volumio[2112]: info: Scanning category user_interface Mar 01 05:04:16 volumio volumio[2112]: info: Scanning into folder /data/plugins/ Mar 01 05:04:16 volumio volumio[2112]: info: Plugin folders cleanup completed Mar 01 05:04:16 volumio volumio[2112]: info: ------------------------------------------- Mar 01 05:04:16 volumio volumio[2112]: info: ----- Core plugins startup ---- Mar 01 05:04:16 volumio volumio[2112]: info: ------------------------------------------- Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugins from folder /volumio/app/plugins/ Mar 01 05:04:16 volumio volumio[2112]: info: Adding plugin upnp to MyMusic Plugins Mar 01 05:04:16 volumio volumio[2112]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 01 05:04:16 volumio volumio[2112]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugins from folder /data/plugins/ Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "system"... Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "appearance"... Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "network"... Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "services"... Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "alsa_controller"... Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "wizard"... Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "volumio_command_line_client"... Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "upnp"... Mar 01 05:04:16 volumio volumio[2112]: info: [1740805456830] Starting Upmpd Daemon Mar 01 05:04:16 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "my_music"... Mar 01 05:04:16 volumio volumio[2112]: info: Loading plugin "mpd"... Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "upnp_browser"... Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "networkfs"... Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "alarm-clock"... Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "airplay_emulation"... Mar 01 05:04:17 volumio volumio[2112]: info: Starting Shairport Sync Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "last_100"... Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "webradio"... Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "i2s_dacs"... Mar 01 05:04:17 volumio volumio[2112]: info: I2S DAC not set, start Auto-detection Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "volumiodiscovery"... Mar 01 05:04:17 volumio volumio[2112]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 01 05:04:17 volumio node[2112]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 01 05:04:17 volumio volumio[2112]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 05:04:17 volumio node[2112]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 05:04:17 volumio volumio[2112]: *** WARNING *** For more information see Mar 01 05:04:17 volumio node[2112]: *** WARNING *** For more information see Mar 01 05:04:17 volumio volumio[2112]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 01 05:04:17 volumio node[2112]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 01 05:04:17 volumio volumio[2112]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 05:04:17 volumio node[2112]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 05:04:17 volumio volumio[2112]: *** WARNING *** For more information see Mar 01 05:04:17 volumio node[2112]: *** WARNING *** For more information see Mar 01 05:04:17 volumio volumio[2112]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 01 05:04:17 volumio volumio[2112]: Discovery: StartAdv! undefined Mar 01 05:04:17 volumio volumio[2112]: Discovery: Started advertising... Volumio - undefined Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "outputs"... Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "albumart"... Mar 01 05:04:17 volumio volumio[2112]: info: Plugin example_plugin is not enabled Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "inputs"... Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "updater_comm"... Mar 01 05:04:17 volumio volumio[2112]: info: Plugin mpdemulation is not enabled Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "rest_api"... Mar 01 05:04:17 volumio volumio[2112]: info: Loading plugin "websocket"... Mar 01 05:04:17 volumio volumio[2112]: info: ___________ START PLUGINS ___________ Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 05:04:17 volumio volumio[2112]: info: [1740805457776] CoreMusicLibrary::Adding element Media Servers Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:17 volumio volumio[2112]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 05:04:17 volumio volumio[2112]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 05:04:17 volumio volumio[2112]: info: [1740805457858] CoreMusicLibrary::Adding element Last_100 Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 05:04:17 volumio volumio[2112]: info: [1740805457860] CoreMusicLibrary::Adding element Webradio Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 05:04:17 volumio volumio[2112]: info: ------------------------------------------- Mar 01 05:04:17 volumio volumio[2112]: info: ----- MyVolumio plugins startup ---- Mar 01 05:04:17 volumio volumio[2112]: info: ------------------------------------------- Mar 01 05:04:17 volumio volumio[2112]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 01 05:04:17 volumio volumio[2112]: info: Loading i18n strings for locale zh Mar 01 05:04:17 volumio volumio[2112]: Forking 3 albumart workers Mar 01 05:04:17 volumio volumio[2112]: Updating browse sources language Mar 01 05:04:17 volumio volumio[2112]: Cannot find translation for sourceMedia Servers Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::initPlayerControls Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: info: BOOT COMPLETED Mar 01 05:04:17 volumio volumio[2112]: [Metrics] CommandRouter: 2s 152.91ms Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:04:17 volumio volumio[2112]: aplay: main:722: audio open error: Device or resource busy Mar 01 05:04:17 volumio volumio[2112]: Cannot play startup sound Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::Close All Modals sent Mar 01 05:04:17 volumio volumio[2112]: info: CoreCommandRouter::Close All Modals sent Mar 01 05:04:17 volumio volumio[2112]: Express server listening on port 3000 Mar 01 05:04:17 volumio volumio[2112]: [Metrics] WebUI: 2s 387.69ms Mar 01 05:04:18 volumio volumio[2112]: Volumio Calling Home Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::resetVolumioState Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::getcurrentVolume Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::volumioRetrievevolume Mar 01 05:04:18 volumio volumio[2112]: info: Setting Device type: Raspberry PI Mar 01 05:04:18 volumio volumio[2112]: info: MPD running with PID691 ,establishing connection Mar 01 05:04:18 volumio sudo[2193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Mar 01 05:04:18 volumio sudo[2193]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:18 volumio volumio[2112]: info: VolumeController:: Volume=100 Mute =false Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::pushState Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::getState Mar 01 05:04:18 volumio volumio[2112]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:18 volumio sudo[2193]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::updateTrackBlock Mar 01 05:04:18 volumio volumio[2112]: info: CorePlayQueue::getTrackBlock Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::volumioRetrievevolume Mar 01 05:04:18 volumio volumio[2112]: Starting albumart workers Mar 01 05:04:18 volumio volumio[2112]: Starting albumart workers Mar 01 05:04:18 volumio volumio[2112]: info: Reloading queue from file Mar 01 05:04:18 volumio volumio[2112]: Starting albumart workers Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::setRepeat false single undefined Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::pushState Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::getState Mar 01 05:04:18 volumio volumio[2112]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::setRandom false Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::pushState Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::getState Mar 01 05:04:18 volumio volumio[2112]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:18 volumio volumio[2112]: info: VolumeController:: Volume=100 Mute =false Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::pushState Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::getState Mar 01 05:04:18 volumio volumio[2112]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:18 volumio volumio[2112]: info: Starting Shairport Sync Mar 01 05:04:18 volumio volumio[2112]: info: Starting Shairport Sync Mar 01 05:04:18 volumio sudo[2213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 05:04:18 volumio sudo[2213]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:18 volumio sudo[2215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 05:04:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 01 05:04:18 volumio sudo[2215]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:18 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 01 05:04:18 volumio sudo[2213]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 05:04:18 volumio volumio[2112]: Discovery: adding 8fe2725e-1bcd-4eb2-950b-10c9a4dbf176 Mar 01 05:04:18 volumio volumio[2112]: info: mDNS: Found device Volumio Mar 01 05:04:18 volumio volumio[2112]: info: CoreCommandRouter::volumioGetState Mar 01 05:04:18 volumio volumio[2112]: info: CoreStateMachine::getState Mar 01 05:04:18 volumio volumio[2112]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 01 05:04:18 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 01 05:04:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 05:04:18 volumio sudo[2215]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:18 volumio sudo[2239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:18 volumio sudo[2239]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:18 volumio sudo[2255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:18 volumio volumio[2112]: info: Shairport-Sync Started Mar 01 05:04:18 volumio sudo[2239]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:18 volumio volumio[2112]: Error adding Membership: Error: addMembership EINVAL Mar 01 05:04:18 volumio volumio[2112]: info: Shairport-Sync Started Mar 01 05:04:18 volumio sudo[2255]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:18 volumio sudo[2255]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:19 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 01 05:04:19 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 01 05:04:19 volumio volumio-remote-updater[622]: [2025-03-01 05:04:19] [connect] Successful connection Mar 01 05:04:19 volumio volumio-remote-updater[622]: [2025-03-01 05:04:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1740805459 101 Mar 01 05:04:20 volumio volumio[2112]: info: CoreCommandRouter::volumioGetState Mar 01 05:04:20 volumio volumio[2112]: info: CoreStateMachine::getState Mar 01 05:04:20 volumio volumio[2112]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:20 volumio sudo[2280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:20 volumio sudo[2280]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:20 volumio sudo[2280]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:21 volumio volumio[2112]: info: Mar 01 05:04:21 volumio volumio[2112]: ---------------------------- Client requests Volume 100 Mar 01 05:04:21 volumio volumio[2112]: info: VolumeController::SetAlsaVolume100 Mar 01 05:04:21 volumio volumio[2112]: info: CoreStateMachine::pushState Mar 01 05:04:21 volumio volumio[2112]: info: CoreStateMachine::getState Mar 01 05:04:21 volumio volumio[2112]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:21 volumio volumio[2112]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:21 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:21 volumio sudo[2295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:21 volumio sudo[2295]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:21 volumio volumio[2112]: info: Setting volume on startup at 100 Mar 01 05:04:21 volumio sudo[2295]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:26 volumio sudo[2314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:26 volumio sudo[2314]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:26 volumio sudo[2317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 01 05:04:26 volumio sudo[2314]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:26 volumio sudo[2317]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:26 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 01 05:04:26 volumio sudo[2317]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:26 volumio volumio[2112]: info: Upmpdcli Daemon Started Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 01 05:04:27 volumio volumio[2112]: info: Adding plugin bluetooth to MyMusic Plugins Mar 01 05:04:27 volumio volumio[2112]: info: Adding plugin cd_controller to MyMusic Plugins Mar 01 05:04:27 volumio volumio[2112]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 01 05:04:27 volumio volumio[2112]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 01 05:04:28 volumio volumio[2112]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 01 05:04:28 volumio volumio[2112]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 01 05:04:28 volumio volumio[2112]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 01 05:04:28 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:04:28 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:04:28 volumio volumio[2112]: info: Starting MyVolumio Remote Streaming Endpoints Mar 01 05:04:28 volumio volumio[2112]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 01 05:04:28 volumio volumio[2112]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 01 05:04:28 volumio volumio[2112]: info: Streaming services startup Mar 01 05:04:28 volumio volumio[2112]: info: Starting Streaming Daemon Mar 01 05:04:28 volumio volumio[2112]: info: MyVolumio not started Mar 01 05:04:28 volumio volumio[2112]: info: Initializing device activation check Mar 01 05:04:28 volumio sudo[2333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 01 05:04:28 volumio sudo[2333]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:28 volumio volumio[2112]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 01 05:04:28 volumio systemd[1]: Stopping Volumio Streaming Daemon... Mar 01 05:04:28 volumio systemd[1]: Starting Volumio Streaming Daemon... Mar 01 05:04:28 volumio systemd[1]: Started Volumio Streaming Daemon. Mar 01 05:04:28 volumio sudo[2333]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:28 volumio volumio[2112]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=8c4a9229368b83ee982bbfbc6c9cc7ba" http://updates.volumio.org:7070/downloader-v1/track-device Mar 01 05:04:28 volumio volumio[2112]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 01 05:04:28 volumio volumio[2112]: Dload Upload Total Spent Left Speed Mar 01 05:04:28 volumio volumio[2112]: [235B blob data] Mar 01 05:04:28 volumio volumio[2112]: retrying in 5 seconds, trial 0 Mar 01 05:04:28 volumio volumio[2112]: Volumio Calling Home Mar 01 05:04:28 volumio volumio-streaming-daemon[2339]: ############################ Mar 01 05:04:28 volumio volumio-streaming-daemon[2339]: # Volumio Streaming Daemon # Mar 01 05:04:28 volumio volumio-streaming-daemon[2339]: # Running on port 7777 # Mar 01 05:04:28 volumio volumio-streaming-daemon[2339]: ############################ Mar 01 05:04:28 volumio volumio-streaming-daemon[2339]: Environment: production Mar 01 05:04:31 volumio volumio-streaming-daemon[2339]: Environment: production Mar 01 05:04:31 volumio volumio[2112]: info: Fetching Streaming Services browse cache Mar 01 05:04:31 volumio volumio[2112]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Mar 01 05:04:31 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:31 volumio volumio[2112]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Mar 01 05:04:31 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:38 volumio volumio[2112]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=8c4a9229368b83ee982bbfbc6c9cc7ba" http://updates.volumio.org:7070/downloader-v1/track-device Mar 01 05:04:38 volumio volumio[2112]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 01 05:04:38 volumio volumio[2112]: Dload Upload Total Spent Left Speed Mar 01 05:04:38 volumio volumio[2112]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 01 05:04:38 volumio volumio[2112]: retrying in 5 seconds, trial 1 Mar 01 05:04:38 volumio volumio[2112]: Volumio Calling Home Mar 01 05:04:47 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 05:04:47 volumio volumio[2112]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:04:49 volumio volumio[2112]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=8c4a9229368b83ee982bbfbc6c9cc7ba" http://updates.volumio.org:7070/downloader-v1/track-device Mar 01 05:04:49 volumio volumio[2112]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 01 05:04:49 volumio volumio[2112]: Dload Upload Total Spent Left Speed Mar 01 05:04:49 volumio volumio[2112]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 01 05:04:49 volumio volumio[2112]: retrying in 5 seconds, trial 2 Mar 01 05:04:49 volumio volumio[2112]: Volumio Calling Home Mar 01 05:04:51 volumio volumio[2112]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 05:04:51 volumio volumio[2112]: { Error: connect ETIMEDOUT 31.13.70.9:443 Mar 01 05:04:51 volumio volumio[2112]: at Object._errnoException (util.js:1022:11) Mar 01 05:04:51 volumio volumio[2112]: at _exceptionWithHostPort (util.js:1044:20) Mar 01 05:04:51 volumio volumio[2112]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 01 05:04:51 volumio volumio[2112]: code: 'ETIMEDOUT', Mar 01 05:04:51 volumio volumio[2112]: errno: 'ETIMEDOUT', Mar 01 05:04:51 volumio volumio[2112]: syscall: 'connect', Mar 01 05:04:51 volumio volumio[2112]: address: '31.13.70.9', Mar 01 05:04:51 volumio volumio[2112]: port: 443 } Mar 01 05:04:51 volumio volumio[2112]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 05:04:51 volumio sudo[2415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 05:03 Mar 01 05:04:51 volumio sudo[2415]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:51 volumio sudo[2415]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:51 volumio volumio-remote-updater[622]: [2025-03-01 05:04:51] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 01 05:04:51 volumio volumio-remote-updater[622]: [2025-03-01 05:04:51] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 01 05:04:51 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Mar 01 05:04:51 volumio systemd[1]: Unit volumio.service entered failed state. Mar 01 05:04:51 volumio systemd[1]: Starting dynamicswap service... Mar 01 05:04:51 volumio systemd[1]: Started dynamicswap service. Mar 01 05:04:52 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Mar 01 05:04:52 volumio systemd[1]: Starting dynamicswap service... Mar 01 05:04:52 volumio systemd[1]: Started dynamicswap service. Mar 01 05:04:52 volumio systemd[1]: Stopping Volumio Backend Module... Mar 01 05:04:52 volumio systemd[1]: Starting Volumio Backend Module... Mar 01 05:04:52 volumio systemd[1]: Started Volumio Backend Module. Mar 01 05:04:53 volumio volumio[2436]: info: ------------------------------------------- Mar 01 05:04:53 volumio volumio[2436]: info: ----- Volumio2 ---- Mar 01 05:04:53 volumio volumio[2436]: info: ------------------------------------------- Mar 01 05:04:53 volumio volumio[2436]: info: ----- System startup ---- Mar 01 05:04:53 volumio volumio[2436]: info: ------------------------------------------- Mar 01 05:04:53 volumio volumio[2436]: info: MYVOLUMIO Environment detected Mar 01 05:04:53 volumio volumio[2436]: info: Plugin folders cleanup Mar 01 05:04:53 volumio volumio[2436]: info: Scanning into folder /volumio/app/plugins/ Mar 01 05:04:53 volumio volumio[2436]: info: Scanning category audio_interface Mar 01 05:04:53 volumio volumio[2436]: info: Scanning category miscellanea Mar 01 05:04:53 volumio volumio[2436]: info: Scanning category music_service Mar 01 05:04:53 volumio volumio[2436]: info: Scanning category plugins.json Mar 01 05:04:53 volumio volumio[2436]: info: Scanning category system_controller Mar 01 05:04:53 volumio volumio[2436]: info: Scanning category user_interface Mar 01 05:04:53 volumio volumio[2436]: info: Scanning into folder /data/plugins/ Mar 01 05:04:53 volumio volumio[2436]: info: Plugin folders cleanup completed Mar 01 05:04:53 volumio volumio[2436]: info: ------------------------------------------- Mar 01 05:04:53 volumio volumio[2436]: info: ----- Core plugins startup ---- Mar 01 05:04:53 volumio volumio[2436]: info: ------------------------------------------- Mar 01 05:04:53 volumio volumio[2436]: info: Loading plugins from folder /volumio/app/plugins/ Mar 01 05:04:53 volumio volumio[2436]: info: Adding plugin upnp to MyMusic Plugins Mar 01 05:04:53 volumio volumio[2436]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 01 05:04:53 volumio volumio[2436]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 01 05:04:53 volumio volumio[2436]: info: Loading plugins from folder /data/plugins/ Mar 01 05:04:53 volumio volumio[2436]: info: Loading plugin "system"... Mar 01 05:04:53 volumio volumio[2436]: info: Loading plugin "appearance"... Mar 01 05:04:53 volumio volumio[2436]: info: Loading plugin "network"... Mar 01 05:04:53 volumio volumio[2436]: info: Loading plugin "services"... Mar 01 05:04:53 volumio volumio[2436]: info: Loading plugin "alsa_controller"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "wizard"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "volumio_command_line_client"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "upnp"... Mar 01 05:04:54 volumio volumio[2436]: info: [1740805494077] Starting Upmpd Daemon Mar 01 05:04:54 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "my_music"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "mpd"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "upnp_browser"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "networkfs"... Mar 01 05:04:54 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "alarm-clock"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "airplay_emulation"... Mar 01 05:04:54 volumio volumio[2436]: info: Starting Shairport Sync Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "last_100"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "webradio"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "i2s_dacs"... Mar 01 05:04:54 volumio volumio[2436]: info: I2S DAC not set, start Auto-detection Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "volumiodiscovery"... Mar 01 05:04:54 volumio volumio[2436]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 01 05:04:54 volumio node[2436]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 01 05:04:54 volumio node[2436]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 05:04:54 volumio node[2436]: *** WARNING *** For more information see Mar 01 05:04:54 volumio node[2436]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 01 05:04:54 volumio node[2436]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 05:04:54 volumio node[2436]: *** WARNING *** For more information see Mar 01 05:04:54 volumio volumio[2436]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 05:04:54 volumio volumio[2436]: *** WARNING *** For more information see Mar 01 05:04:54 volumio volumio[2436]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 01 05:04:54 volumio volumio[2436]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 01 05:04:54 volumio volumio[2436]: *** WARNING *** For more information see Mar 01 05:04:54 volumio volumio[2436]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 01 05:04:54 volumio volumio[2436]: Discovery: StartAdv! undefined Mar 01 05:04:54 volumio volumio[2436]: Discovery: Started advertising... Volumio - undefined Mar 01 05:04:54 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "outputs"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "albumart"... Mar 01 05:04:54 volumio volumio[2436]: info: Plugin example_plugin is not enabled Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "inputs"... Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "updater_comm"... Mar 01 05:04:54 volumio volumio[2436]: info: Plugin mpdemulation is not enabled Mar 01 05:04:54 volumio volumio[2436]: info: Loading plugin "rest_api"... Mar 01 05:04:55 volumio volumio[2436]: info: Loading plugin "websocket"... Mar 01 05:04:55 volumio volumio[2436]: info: ___________ START PLUGINS ___________ Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 05:04:55 volumio volumio[2436]: info: [1740805495031] CoreMusicLibrary::Adding element Media Servers Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:55 volumio volumio[2436]: Forking 3 albumart workers Mar 01 05:04:55 volumio volumio[2436]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 05:04:55 volumio volumio[2436]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 05:04:55 volumio volumio[2436]: info: [1740805495126] CoreMusicLibrary::Adding element Last_100 Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 01 05:04:55 volumio volumio[2436]: info: [1740805495129] CoreMusicLibrary::Adding element Webradio Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 05:04:55 volumio volumio[2436]: info: ------------------------------------------- Mar 01 05:04:55 volumio volumio[2436]: info: ----- MyVolumio plugins startup ---- Mar 01 05:04:55 volumio volumio[2436]: info: ------------------------------------------- Mar 01 05:04:55 volumio volumio[2436]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 01 05:04:55 volumio volumio[2436]: info: Loading i18n strings for locale zh Mar 01 05:04:55 volumio volumio[2436]: Updating browse sources language Mar 01 05:04:55 volumio volumio[2436]: Cannot find translation for sourceMedia Servers Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::initPlayerControls Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: info: BOOT COMPLETED Mar 01 05:04:55 volumio volumio[2436]: [Metrics] CommandRouter: 2s 177.06ms Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:04:55 volumio volumio[2436]: aplay: main:722: audio open error: Device or resource busy Mar 01 05:04:55 volumio volumio[2436]: Cannot play startup sound Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::Close All Modals sent Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::Close All Modals sent Mar 01 05:04:55 volumio volumio[2436]: Express server listening on port 3000 Mar 01 05:04:55 volumio volumio[2436]: [Metrics] WebUI: 2s 422.12ms Mar 01 05:04:55 volumio volumio[2436]: Volumio Calling Home Mar 01 05:04:55 volumio volumio[2436]: info: CoreStateMachine::resetVolumioState Mar 01 05:04:55 volumio volumio[2436]: info: CoreStateMachine::getcurrentVolume Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::volumioRetrievevolume Mar 01 05:04:55 volumio volumio[2436]: info: Setting Device type: Raspberry PI Mar 01 05:04:55 volumio volumio[2436]: info: MPD running with PID691 ,establishing connection Mar 01 05:04:55 volumio sudo[2517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Mar 01 05:04:55 volumio sudo[2517]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:55 volumio volumio[2436]: Starting albumart workers Mar 01 05:04:55 volumio volumio[2436]: Starting albumart workers Mar 01 05:04:55 volumio sudo[2517]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:55 volumio volumio[2436]: Starting albumart workers Mar 01 05:04:55 volumio volumio[2436]: info: VolumeController:: Volume=100 Mute =false Mar 01 05:04:55 volumio volumio[2436]: info: CoreStateMachine::pushState Mar 01 05:04:55 volumio volumio[2436]: info: CoreStateMachine::getState Mar 01 05:04:55 volumio volumio[2436]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:55 volumio volumio[2436]: info: CoreStateMachine::updateTrackBlock Mar 01 05:04:55 volumio volumio[2436]: info: CorePlayQueue::getTrackBlock Mar 01 05:04:55 volumio volumio[2436]: info: CoreCommandRouter::volumioRetrievevolume Mar 01 05:04:55 volumio volumio[2436]: info: Reloading queue from file Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::setRepeat false single undefined Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::pushState Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::getState Mar 01 05:04:56 volumio volumio[2436]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::setRandom false Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::pushState Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::getState Mar 01 05:04:56 volumio volumio[2436]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:56 volumio volumio[2436]: info: Starting Shairport Sync Mar 01 05:04:56 volumio volumio[2436]: info: Starting Shairport Sync Mar 01 05:04:56 volumio sudo[2541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 05:04:56 volumio sudo[2541]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:56 volumio volumio[2436]: info: VolumeController:: Volume=100 Mute =false Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::pushState Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::getState Mar 01 05:04:56 volumio volumio[2436]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:56 volumio sudo[2543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:56 volumio sudo[2543]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 01 05:04:56 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 01 05:04:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 05:04:56 volumio sudo[2541]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 01 05:04:56 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 01 05:04:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 05:04:56 volumio sudo[2543]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:56 volumio volumio[2436]: Discovery: adding 8fe2725e-1bcd-4eb2-950b-10c9a4dbf176 Mar 01 05:04:56 volumio volumio[2436]: info: mDNS: Found device Volumio Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::volumioGetState Mar 01 05:04:56 volumio volumio[2436]: info: CoreStateMachine::getState Mar 01 05:04:56 volumio volumio[2436]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:56 volumio sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:56 volumio sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:56 volumio volumio[2436]: info: Shairport-Sync Started Mar 01 05:04:56 volumio volumio[2436]: Error adding Membership: Error: addMembership EINVAL Mar 01 05:04:56 volumio sudo[2572]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:56 volumio sudo[2576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:56 volumio volumio[2436]: info: Shairport-Sync Started Mar 01 05:04:56 volumio sudo[2576]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:56 volumio sudo[2576]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 01 05:04:56 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 01 05:04:56 volumio volumio-remote-updater[622]: [2025-03-01 05:04:56] [connect] Successful connection Mar 01 05:04:56 volumio volumio-remote-updater[622]: [2025-03-01 05:04:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1740805496 101 Mar 01 05:04:57 volumio volumio[2436]: info: CoreCommandRouter::volumioGetVisibleSources Mar 01 05:04:57 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:04:57 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 01 05:04:57 volumio volumio[2436]: info: CoreCommandRouter::volumioGetState Mar 01 05:04:57 volumio volumio[2436]: info: CoreStateMachine::getState Mar 01 05:04:57 volumio volumio[2436]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:57 volumio sudo[2594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:57 volumio sudo[2594]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:57 volumio sudo[2594]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:57 volumio sudo[2598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:57 volumio sudo[2598]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:57 volumio sudo[2598]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:57 volumio volumio[2436]: info: Listing playlists Mar 01 05:04:57 volumio volumio[2436]: info: CoreCommandRouter::volumioGetQueue Mar 01 05:04:57 volumio volumio[2436]: info: CoreStateMachine::getQueue Mar 01 05:04:57 volumio volumio[2436]: info: CorePlayQueue::getQueue Mar 01 05:04:58 volumio volumio[2436]: info: CoreCommandRouter::volumioGetState Mar 01 05:04:58 volumio volumio[2436]: info: CoreStateMachine::getState Mar 01 05:04:58 volumio volumio[2436]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:58 volumio sudo[2614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:58 volumio sudo[2614]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:58 volumio sudo[2614]: pam_unix(sudo:session): session closed for user root Mar 01 05:04:59 volumio volumio[2436]: info: Mar 01 05:04:59 volumio volumio[2436]: ---------------------------- Client requests Volume 100 Mar 01 05:04:59 volumio volumio[2436]: info: VolumeController::SetAlsaVolume100 Mar 01 05:04:59 volumio volumio[2436]: info: CoreStateMachine::pushState Mar 01 05:04:59 volumio volumio[2436]: info: CoreStateMachine::getState Mar 01 05:04:59 volumio volumio[2436]: info: CorePlayQueue::getTrack 0 Mar 01 05:04:59 volumio volumio[2436]: info: CoreCommandRouter::volumioPushState Mar 01 05:04:59 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 05:04:59 volumio sudo[2627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:04:59 volumio sudo[2627]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:04:59 volumio volumio[2436]: info: Setting volume on startup at 100 Mar 01 05:04:59 volumio sudo[2627]: pam_unix(sudo:session): session closed for user root Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%B5%E5%9C%8B%E6%A6%AE/Forever/ee207235-4b8b-4215-8d2a-f90b17854735.png' Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyonc%C3%A9/I%20Am...Sasha%20Fierce%20Deluxe%20Edition/71360d53-82c8-4b63-9ff7-3ee2caddebb8.jpg' Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Elvis%20Costello/Notting%20Hill%20Original%20Soundtrack/3c8a176f-9a89-450f-9434-6b741ac3f394.jpg' Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9B%B9%E6%A0%BC/Superman/bdaa538a-5c49-4eb6-9be8-bec3748abb30.jpg' Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E5%A5%95%E8%BF%85/Stranger%20Under%20My%20Skin/eca95d57-faae-4f17-b849-b3ed7c5f9787.jpg' Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Queen/News%20Of%20The%20World%20(Remastered%20Deluxe%20Edition)/a4529e56-b79a-4560-83e5-a6717696448f.png' Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%8E%E5%81%A5/%E4%BC%BC%E6%B0%B4%E6%B5%81%E5%B9%B4/f34865b8-060a-4797-a903-7bc855af3677.jpg' Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E4%BC%8D%E4%BC%AF/%E6%BB%9A%E7%9F%B3%E9%A6%99%E6%B8%AF%E9%BB%84%E9%87%91%E5%8D%81%E5%B9%B4%E4%BC%8D%E4%BC%AF%E7%B2%BE%E9%80%89/fea05f7e-c18f-4339-9e55-260202c0dab6.jpg' Mar 01 05:05:01 volumio volumio[2436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AE%8B%E5%86%AC%E9%87%8E/%E6%91%A9%E7%99%BB%E5%A4%A9%E7%A9%BA7/67a96674-11f2-4662-8989-41b920756b02.jpg' Mar 01 05:05:04 volumio sudo[2662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 05:05:04 volumio sudo[2662]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:05:04 volumio sudo[2662]: pam_unix(sudo:session): session closed for user root Mar 01 05:05:04 volumio sudo[2666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 01 05:05:04 volumio sudo[2666]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:05:04 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 01 05:05:04 volumio sudo[2666]: pam_unix(sudo:session): session closed for user root Mar 01 05:05:04 volumio volumio[2436]: info: Upmpdcli Daemon Started Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 01 05:05:04 volumio volumio[2436]: info: Adding plugin bluetooth to MyMusic Plugins Mar 01 05:05:04 volumio volumio[2436]: info: Adding plugin cd_controller to MyMusic Plugins Mar 01 05:05:04 volumio volumio[2436]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 01 05:05:04 volumio volumio[2436]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 01 05:05:05 volumio volumio[2436]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 01 05:05:05 volumio volumio[2436]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 01 05:05:05 volumio volumio[2436]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 01 05:05:05 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:05:05 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:05:05 volumio volumio[2436]: info: Starting MyVolumio Remote Streaming Endpoints Mar 01 05:05:05 volumio volumio[2436]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 01 05:05:05 volumio volumio[2436]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 01 05:05:05 volumio volumio[2436]: info: Streaming services startup Mar 01 05:05:05 volumio volumio[2436]: info: Starting Streaming Daemon Mar 01 05:05:05 volumio volumio[2436]: info: MyVolumio not started Mar 01 05:05:06 volumio volumio[2436]: info: Initializing device activation check Mar 01 05:05:06 volumio sudo[2682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 01 05:05:06 volumio sudo[2682]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 05:05:06 volumio volumio[2436]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 01 05:05:06 volumio systemd[1]: Stopping Volumio Streaming Daemon... Mar 01 05:05:06 volumio systemd[1]: Starting Volumio Streaming Daemon... Mar 01 05:05:06 volumio systemd[1]: Started Volumio Streaming Daemon. Mar 01 05:05:06 volumio sudo[2682]: pam_unix(sudo:session): session closed for user root Mar 01 05:05:06 volumio volumio[2436]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=8c4a9229368b83ee982bbfbc6c9cc7ba" http://updates.volumio.org:7070/downloader-v1/track-device Mar 01 05:05:06 volumio volumio[2436]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 01 05:05:06 volumio volumio[2436]: Dload Upload Total Spent Left Speed Mar 01 05:05:06 volumio volumio[2436]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 01 05:05:06 volumio volumio[2436]: retrying in 5 seconds, trial 0 Mar 01 05:05:06 volumio volumio-streaming-daemon[2688]: ############################ Mar 01 05:05:06 volumio volumio-streaming-daemon[2688]: # Volumio Streaming Daemon # Mar 01 05:05:06 volumio volumio-streaming-daemon[2688]: # Running on port 7777 # Mar 01 05:05:06 volumio volumio-streaming-daemon[2688]: ############################ Mar 01 05:05:06 volumio volumio[2436]: Volumio Calling Home Mar 01 05:05:06 volumio volumio-streaming-daemon[2688]: Environment: production Mar 01 05:05:08 volumio volumio-streaming-daemon[2688]: Environment: production Mar 01 05:05:08 volumio volumio[2436]: info: Fetching Streaming Services browse cache Mar 01 05:05:08 volumio volumio[2436]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Mar 01 05:05:08 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:05:08 volumio volumio[2436]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Mar 01 05:05:08 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 05:05:16 volumio volumio[2436]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=8c4a9229368b83ee982bbfbc6c9cc7ba" http://updates.volumio.org:7070/downloader-v1/track-device Mar 01 05:05:16 volumio volumio[2436]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 01 05:05:16 volumio volumio[2436]: Dload Upload Total Spent Left Speed Mar 01 05:05:16 volumio volumio[2436]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 01 05:05:16 volumio volumio[2436]: retrying in 5 seconds, trial 1 Mar 01 05:05:16 volumio volumio[2436]: Volumio Calling Home Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 01 05:05:25 volumio volumio[2436]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 05:05:26 volumio volumio[2436]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=8c4a9229368b83ee982bbfbc6c9cc7ba" http://updates.volumio.org:7070/downloader-v1/track-device Mar 01 05:05:26 volumio volumio[2436]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 01 05:05:26 volumio volumio[2436]: Dload Upload Total Spent Left Speed Mar 01 05:05:26 volumio volumio[2436]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 01 05:05:26 volumio volumio[2436]: retrying in 5 seconds, trial 2 Mar 01 05:05:26 volumio volumio[2436]: Volumio Calling Home Mar 01 05:05:28 volumio volumio[2436]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 05:05:28 volumio volumio[2436]: { Error: connect ETIMEDOUT 192.133.77.133:443 Mar 01 05:05:28 volumio volumio[2436]: at Object._errnoException (util.js:1022:11) Mar 01 05:05:28 volumio volumio[2436]: at _exceptionWithHostPort (util.js:1044:20) Mar 01 05:05:28 volumio volumio[2436]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 01 05:05:28 volumio volumio[2436]: code: 'ETIMEDOUT', Mar 01 05:05:28 volumio volumio[2436]: errno: 'ETIMEDOUT', Mar 01 05:05:28 volumio volumio[2436]: syscall: 'connect', Mar 01 05:05:28 volumio volumio[2436]: address: '192.133.77.133', Mar 01 05:05:28 volumio volumio[2436]: port: 443 } Mar 01 05:05:28 volumio volumio[2436]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 05:05:28 volumio sudo[2770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 05:04 Mar 01 05:05:28 volumio sudo[2770]: 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="ba22215fabbe766d668749499a1c25fcefd90f0a" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="043dcaee624f27d121213b83af11a9f2feac0945" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 18 01:32:43 CET 2020" VOLUMIO_VERSION="2.729" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5a0b29326faa8f5d0f5fe95d9e58c069"