-- Logs begin at Sat 2025-01-11 16:17:01 UTC, end at Sat 2025-01-11 17:55:58 UTC. -- Jan 11 17:55:04 ek-musica systemd[1]: Time has been changed Jan 11 17:55:04 ek-musica volumio[1198]: info: Loading plugin "airplay_emulation"... Jan 11 17:55:04 ek-musica volumio[1198]: info: Starting Shairport Sync Jan 11 17:55:04 ek-musica volumio[1198]: info: Loading plugin "last_100"... Jan 11 17:55:04 ek-musica volumio[1198]: info: Loading plugin "webradio"... Jan 11 17:55:04 ek-musica volumio[1198]: info: Loading plugin "i2s_dacs"... Jan 11 17:55:04 ek-musica volumio[1198]: info: I2S DAC not set, start Auto-detection Jan 11 17:55:04 ek-musica volumio[1198]: info: Loading plugin "volumiodiscovery"... Jan 11 17:55:04 ek-musica volumio[1198]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 11 17:55:04 ek-musica node[1198]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 11 17:55:04 ek-musica volumio[1198]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 17:55:04 ek-musica node[1198]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 17:55:04 ek-musica volumio[1198]: *** WARNING *** For more information see Jan 11 17:55:04 ek-musica node[1198]: *** WARNING *** For more information see Jan 11 17:55:04 ek-musica volumio[1198]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 11 17:55:04 ek-musica node[1198]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 11 17:55:04 ek-musica volumio[1198]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 17:55:04 ek-musica node[1198]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 17:55:04 ek-musica node[1198]: *** WARNING *** For more information see Jan 11 17:55:04 ek-musica volumio[1198]: *** WARNING *** For more information see Jan 11 17:55:04 ek-musica volumio[1198]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 11 17:55:04 ek-musica volumio[1198]: Discovery: StartAdv! undefined Jan 11 17:55:04 ek-musica volumio[1198]: Discovery: Started advertising... ek-musica - undefined Jan 11 17:55:04 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 11 17:55:04 ek-musica volumio[1198]: info: Loading plugin "auto_play"... Jan 11 17:55:04 ek-musica volumio[1198]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Jan 11 17:55:04 ek-musica volumio[1198]: info: Loading plugin "autostart"... Jan 11 17:55:05 ek-musica volumio[1198]: info: Applying required configuration parameters for plugin autostart Jan 11 17:55:05 ek-musica volumio[1198]: info: Loading plugin "outputs"... Jan 11 17:55:05 ek-musica volumio[1198]: info: Loading plugin "albumart"... Jan 11 17:55:05 ek-musica volumio[1198]: info: Plugin example_plugin is not enabled Jan 11 17:55:05 ek-musica volumio[1198]: info: Loading plugin "inputs"... Jan 11 17:55:05 ek-musica volumio[1198]: info: Loading plugin "updater_comm"... Jan 11 17:55:05 ek-musica volumio[1198]: info: Plugin mpdemulation is not enabled Jan 11 17:55:05 ek-musica volumio[1198]: info: Loading plugin "rest_api"... Jan 11 17:55:05 ek-musica volumio[1198]: info: Loading plugin "websocket"... Jan 11 17:55:05 ek-musica volumio[1198]: info: ___________ START PLUGINS ___________ Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 17:55:05 ek-musica volumio[1198]: info: [1736618105362] CoreMusicLibrary::Adding element Media Servers Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:05 ek-musica volumio[1198]: Forking 3 albumart workers Jan 11 17:55:05 ek-musica volumio[1198]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 11 17:55:05 ek-musica volumio[1198]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 17:55:05 ek-musica volumio[1198]: info: [1736618105483] CoreMusicLibrary::Adding element Last_100 Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 17:55:05 ek-musica volumio[1198]: info: [1736618105489] CoreMusicLibrary::Adding element Webradio Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 11 17:55:05 ek-musica volumio[1198]: info: ------------------------------------------- Jan 11 17:55:05 ek-musica volumio[1198]: info: ----- MyVolumio plugins startup ---- Jan 11 17:55:05 ek-musica volumio[1198]: info: ------------------------------------------- Jan 11 17:55:05 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 11 17:55:05 ek-musica volumio[1198]: info: Loading i18n strings for locale es Jan 11 17:55:05 ek-musica volumio[1198]: Updating browse sources language Jan 11 17:55:05 ek-musica volumio[1198]: Cannot find translation for sourceMedia Servers Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::initPlayerControls Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 17:55:05 ek-musica volumio[1198]: info: BOOT COMPLETED Jan 11 17:55:05 ek-musica volumio[1198]: [Metrics] CommandRouter: 5s 538.84ms Jan 11 17:55:05 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:06 ek-musica volumio[1198]: Starting albumart workers Jan 11 17:55:06 ek-musica volumio[1198]: Starting albumart workers Jan 11 17:55:06 ek-musica volumio[1198]: Starting albumart workers Jan 11 17:55:06 ek-musica volumio-remote-updater[593]: [2025-01-11 17:55:06] [connect] Successful connection Jan 11 17:55:10 ek-musica volumio[1198]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 11 17:55:10 ek-musica volumio[1198]: info: CoreCommandRouter::Close All Modals sent Jan 11 17:55:10 ek-musica volumio[1198]: info: CoreCommandRouter::Close All Modals sent Jan 11 17:55:10 ek-musica volumio[1198]: Express server listening on port 3000 Jan 11 17:55:10 ek-musica volumio[1198]: [Metrics] WebUI: 11s 579.43ms Jan 11 17:55:11 ek-musica volumio[1198]: Volumio Calling Home Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::resetVolumioState Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::getcurrentVolume Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::volumioRetrievevolume Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:11 ek-musica volumio[1198]: info: Setting Device type: Raspberry PI Jan 11 17:55:11 ek-musica volumio[1198]: info: MPD running with PID690 Jan 11 17:55:11 ek-musica volumio[1198]: ,establishing connection Jan 11 17:55:11 ek-musica sudo[1327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jan 11 17:55:11 ek-musica sudo[1327]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:11 ek-musica volumio-remote-updater[593]: [2025-01-11 17:55:11] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1736618106 101 Jan 11 17:55:11 ek-musica sudo[1327]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:11 ek-musica volumio[1198]: info: VolumeController:: Volume=100 Mute =false Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::pushState Jan 11 17:55:11 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::updateTrackBlock Jan 11 17:55:11 ek-musica volumio[1198]: info: CorePlayQueue::getTrackBlock Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::volumioRetrievevolume Jan 11 17:55:11 ek-musica volumio[1198]: error: error Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:11 ek-musica volumio[1198]: info: Reloading queue from file Jan 11 17:55:11 ek-musica volumio[1198]: error: updateQueue error: null Jan 11 17:55:11 ek-musica volumio[1198]: error: Failed LSINFO: Error: [50@0] {} No such directory Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::setRepeat true single undefined Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::pushState Jan 11 17:55:11 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::setRandom true Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::pushState Jan 11 17:55:11 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:11 ek-musica volumio[1198]: info: VolumeController:: Volume=100 Mute =false Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreStateMachine::pushState Jan 11 17:55:11 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:11 ek-musica volumio[1198]: info: Starting Shairport Sync Jan 11 17:55:11 ek-musica volumio[1198]: info: Starting Shairport Sync Jan 11 17:55:11 ek-musica sudo[1339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 11 17:55:11 ek-musica volumio[1198]: Discovery: adding a51ef31c-7c06-4685-b34f-2fde1e442189 Jan 11 17:55:11 ek-musica volumio[1198]: info: mDNS: Found device ek-musica Jan 11 17:55:11 ek-musica sudo[1339]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:11 ek-musica volumio[1198]: info: CoreCommandRouter::volumioGetState Jan 11 17:55:11 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:11 ek-musica sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 11 17:55:11 ek-musica sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:11 ek-musica systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 11 17:55:11 ek-musica systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 11 17:55:11 ek-musica sudo[1339]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:11 ek-musica systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 11 17:55:11 ek-musica systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 11 17:55:11 ek-musica systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 11 17:55:11 ek-musica sudo[1341]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:11 ek-musica volumio[1198]: info: Shairport-Sync Started Jan 11 17:55:11 ek-musica volumio[1198]: Error adding Membership: Error: addMembership EINVAL Jan 11 17:55:12 ek-musica volumio[1198]: info: Shairport-Sync Started Jan 11 17:55:12 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 11 17:55:12 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 11 17:55:12 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 11 17:55:12 ek-musica volumio[1198]: info: ControllerAutoPlay - mpd ready Jan 11 17:55:12 ek-musica volumio[1198]: info: CoreCommandRouter::volumioGetState Jan 11 17:55:12 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:12 ek-musica nmbd[1154]: [2025/01/11 17:55:12.567229, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jan 11 17:55:12 ek-musica nmbd[1154]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.240 for name WORKGROUP<1d>. Jan 11 17:55:12 ek-musica nmbd[1154]: This response was from IP 192.168.1.200, reporting an IP address of 192.168.1.200. Jan 11 17:55:13 ek-musica sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 17:55:13 ek-musica sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:13 ek-musica sudo[1372]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:13 ek-musica sudo[1376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 17:55:13 ek-musica sudo[1376]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:13 ek-musica sudo[1376]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:13 ek-musica sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 11 17:55:13 ek-musica sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:13 ek-musica sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 17:55:13 ek-musica systemd[1]: Starting UPnP Renderer front-end to MPD... Jan 11 17:55:13 ek-musica systemd[1]: Started UPnP Renderer front-end to MPD. Jan 11 17:55:13 ek-musica sudo[1398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 17:55:13 ek-musica sudo[1384]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:13 ek-musica sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:13 ek-musica sudo[1398]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:13 ek-musica volumio[1198]: info: Upmpdcli Daemon Started Jan 11 17:55:13 ek-musica sudo[1394]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:13 ek-musica sudo[1398]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 11 17:55:13 ek-musica volumio[1198]: info: Adding plugin bluetooth to MyMusic Plugins Jan 11 17:55:13 ek-musica volumio[1198]: info: Adding plugin cd_controller to MyMusic Plugins Jan 11 17:55:13 ek-musica volumio[1198]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 11 17:55:13 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 11 17:55:16 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 11 17:55:17 ek-musica volumio[1198]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 11 17:55:17 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:17 ek-musica volumio[1198]: info: Starting MyVolumio Remote Streaming Endpoints Jan 11 17:55:17 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 11 17:55:17 ek-musica volumio[1198]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 11 17:55:17 ek-musica volumio[1198]: info: Streaming services startup Jan 11 17:55:17 ek-musica volumio[1198]: info: Starting Streaming Daemon Jan 11 17:55:17 ek-musica sudo[1431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 11 17:55:17 ek-musica sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:17 ek-musica systemd[1]: Stopping Volumio Streaming Daemon... Jan 11 17:55:17 ek-musica volumio[1198]: info: MyVolumio not started Jan 11 17:55:17 ek-musica volumio[1198]: info: Initializing device activation check Jan 11 17:55:17 ek-musica systemd[1]: Starting Volumio Streaming Daemon... Jan 11 17:55:17 ek-musica sudo[1431]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:17 ek-musica systemd[1]: Started Volumio Streaming Daemon. Jan 11 17:55:17 ek-musica volumio-streaming-daemon[1441]: ############################ Jan 11 17:55:17 ek-musica volumio-streaming-daemon[1441]: # Volumio Streaming Daemon # Jan 11 17:55:17 ek-musica volumio-streaming-daemon[1441]: # Running on port 7777 # Jan 11 17:55:17 ek-musica volumio-streaming-daemon[1441]: ############################ Jan 11 17:55:17 ek-musica volumio-streaming-daemon[1441]: Environment: production Jan 11 17:55:17 ek-musica volumio[1198]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 11 17:55:17 ek-musica volumio[1198]: info: ControllerAutoPlay - getting queue Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::volumioGetQueue Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreStateMachine::getQueue Jan 11 17:55:17 ek-musica volumio[1198]: info: CorePlayQueue::getQueue Jan 11 17:55:17 ek-musica volumio[1198]: info: ControllerAutoPlay - start playing -> queue is not empty Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPlay Jan 11 17:55:17 ek-musica volumio[1198]: UNSET VOLATILE Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreStateMachine::play index undefined Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 17:55:17 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreStateMachine::startPlaybackTimer Jan 11 17:55:17 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/christmas/christmas (115).mp3 Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 17:55:17 ek-musica volumio[1198]: info: Jan 11 17:55:17 ek-musica volumio[1198]: ---------------------------- MPD announces system playlist update Jan 11 17:55:17 ek-musica volumio[1198]: info: Ignoring MPD Status Update Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/christmas/christmas (115).mp3" Jan 11 17:55:17 ek-musica volumio[1198]: error: updateQueue error: null Jan 11 17:55:17 ek-musica volumio[1198]: info: Jan 11 17:55:17 ek-musica volumio[1198]: ---------------------------- MPD announces system playlist update Jan 11 17:55:17 ek-musica volumio[1198]: info: Ignoring MPD Status Update Jan 11 17:55:17 ek-musica volumio[1198]: info: ------------------------------ 17ms Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand play Jan 11 17:55:17 ek-musica volumio[1198]: info: ------------------------------ 9ms Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::volumioGetVisibleSources Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::volumioGetState Jan 11 17:55:17 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::volumioGetQueue Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreStateMachine::getQueue Jan 11 17:55:17 ek-musica volumio[1198]: info: CorePlayQueue::getQueue Jan 11 17:55:17 ek-musica volumio[1198]: info: Listing playlists Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 11 17:55:17 ek-musica volumio[1198]: info: Jan 11 17:55:17 ek-musica volumio[1198]: ---------------------------- MPD announces state update: player Jan 11 17:55:17 ek-musica volumio[1198]: info: ControllerMpd::getState Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:55:17 ek-musica volumio[1198]: info: Jan 11 17:55:17 ek-musica volumio[1198]: ---------------------------- MPD announces state update: player Jan 11 17:55:17 ek-musica volumio[1198]: info: ControllerMpd::getState Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::parseState Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::parseState Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:55:17 ek-musica volumio[1198]: verbose: ControllerMpd::parseTrackInfo Jan 11 17:55:17 ek-musica volumio[1198]: info: ControllerMpd::pushState Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::servicePushState Jan 11 17:55:17 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:17 ek-musica volumio[1198]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":167,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"2000 Miles","artist":"GRACEY","album":"2000 Miles","uri":"INTERNAL/christmas/christmas (115).mp3","trackType":"mp3"} Jan 11 17:55:17 ek-musica volumio[1198]: verbose: CURRENT POSITION 0 Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreStateMachine::syncState stateService play Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreStateMachine::syncState currentStatus stop Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreStateMachine::pushState Jan 11 17:55:17 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:17 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:18 ek-musica volumio[1198]: info: ------------------------------ 72ms Jan 11 17:55:18 ek-musica volumio[1198]: verbose: ControllerMpd::parseTrackInfo Jan 11 17:55:18 ek-musica volumio[1198]: info: ControllerMpd::pushState Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreCommandRouter::servicePushState Jan 11 17:55:18 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:18 ek-musica volumio[1198]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":167,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"2000 Miles","artist":"GRACEY","album":"2000 Miles","uri":"INTERNAL/christmas/christmas (115).mp3","trackType":"mp3"} Jan 11 17:55:18 ek-musica volumio[1198]: verbose: CURRENT POSITION 0 Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreStateMachine::syncState stateService play Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreStateMachine::syncState currentStatus play Jan 11 17:55:18 ek-musica volumio[1198]: info: Received an update from plugin. extracting info from payload Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreStateMachine::pushState Jan 11 17:55:18 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreStateMachine::pushState Jan 11 17:55:18 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:18 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:18 ek-musica volumio[1198]: info: ------------------------------ 52ms Jan 11 17:55:20 ek-musica volumio-streaming-daemon[1441]: Environment: production Jan 11 17:55:20 ek-musica volumio[1198]: info: Fetching Streaming Services browse cache Jan 11 17:55:21 ek-musica volumio[1198]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=b1c450b1438bce6d2cf19261a5df4b24" http://updates.volumio.org:7070/downloader-v1/track-device Jan 11 17:55:21 ek-musica volumio[1198]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 11 17:55:21 ek-musica volumio[1198]: Dload Upload Total Spent Left Speed Jan 11 17:55:21 ek-musica volumio[1198]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 11 17:55:21 ek-musica volumio[1198]: retrying in 5 seconds, trial 0 Jan 11 17:55:21 ek-musica volumio[1198]: Volumio Calling Home Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPause Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreStateMachine::pause Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreStateMachine::stPlaybackTimer Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreStateMachine::servicePause Jan 11 17:55:22 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreCommandRouter::servicePause Jan 11 17:55:22 ek-musica volumio[1198]: info: ControllerMpd::pause Jan 11 17:55:22 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand pause Jan 11 17:55:22 ek-musica volumio[1198]: info: Jan 11 17:55:22 ek-musica volumio[1198]: ---------------------------- MPD announces state update: player Jan 11 17:55:22 ek-musica volumio[1198]: info: ControllerMpd::getState Jan 11 17:55:22 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:55:22 ek-musica volumio[1198]: verbose: ControllerMpd::parseState Jan 11 17:55:22 ek-musica volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:55:22 ek-musica volumio[1198]: verbose: ControllerMpd::parseTrackInfo Jan 11 17:55:22 ek-musica volumio[1198]: info: ControllerMpd::pushState Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreCommandRouter::servicePushState Jan 11 17:55:22 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:22 ek-musica volumio[1198]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4618,"duration":167,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"2000 Miles","artist":"GRACEY","album":"2000 Miles","uri":"INTERNAL/christmas/christmas (115).mp3","trackType":"mp3"} Jan 11 17:55:22 ek-musica volumio[1198]: verbose: CURRENT POSITION 0 Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreStateMachine::syncState stateService pause Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreStateMachine::syncState currentStatus pause Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreStateMachine::pushState Jan 11 17:55:22 ek-musica volumio[1198]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:22 ek-musica volumio[1198]: info: CoreStateMachine::stPlaybackTimer Jan 11 17:55:22 ek-musica volumio[1198]: info: ------------------------------ 15ms Jan 11 17:55:23 ek-musica volumio[1198]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 17:55:23 ek-musica volumio[1198]: { Error: read ECONNRESET Jan 11 17:55:23 ek-musica volumio[1198]: at _errnoException (util.js:1022:11) Jan 11 17:55:23 ek-musica volumio[1198]: at TLSWrap.onread (net.js:628:25) code: 'ECONNRESET', errno: 'ECONNRESET', syscall: 'read' } Jan 11 17:55:23 ek-musica volumio[1198]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 17:55:24 ek-musica sudo[1478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-11 17:54 Jan 11 17:55:24 ek-musica sudo[1478]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:24 ek-musica sudo[1478]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:25 ek-musica volumio-remote-updater[593]: [2025-01-11 17:55:25] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 11 17:55:25 ek-musica volumio-remote-updater[593]: [2025-01-11 17:55:25] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 11 17:55:25 ek-musica systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Jan 11 17:55:25 ek-musica systemd[1]: Unit volumio.service entered failed state. Jan 11 17:55:25 ek-musica systemd[1]: Starting dynamicswap service... Jan 11 17:55:25 ek-musica systemd[1]: Started dynamicswap service. Jan 11 17:55:25 ek-musica systemd[1]: volumio.service holdoff time over, scheduling restart. Jan 11 17:55:25 ek-musica systemd[1]: Starting dynamicswap service... Jan 11 17:55:25 ek-musica systemd[1]: Started dynamicswap service. Jan 11 17:55:25 ek-musica systemd[1]: Stopping Volumio Backend Module... Jan 11 17:55:25 ek-musica systemd[1]: Starting Volumio Backend Module... Jan 11 17:55:25 ek-musica systemd[1]: Started Volumio Backend Module. Jan 11 17:55:26 ek-musica volumio[1505]: info: ------------------------------------------- Jan 11 17:55:26 ek-musica volumio[1505]: info: ----- Volumio2 ---- Jan 11 17:55:26 ek-musica volumio[1505]: info: ------------------------------------------- Jan 11 17:55:26 ek-musica volumio[1505]: info: ----- System startup ---- Jan 11 17:55:26 ek-musica volumio[1505]: info: ------------------------------------------- Jan 11 17:55:27 ek-musica volumio[1505]: info: MYVOLUMIO Environment detected Jan 11 17:55:27 ek-musica volumio[1505]: info: Plugin folders cleanup Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning into folder /volumio/app/plugins/ Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning category audio_interface Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning category miscellanea Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning category music_service Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning category plugins.json Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning category system_controller Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning category user_interface Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning into folder /data/plugins/ Jan 11 17:55:27 ek-musica volumio[1505]: info: Scanning category miscellanea Jan 11 17:55:27 ek-musica volumio[1505]: info: Plugin folders cleanup completed Jan 11 17:55:27 ek-musica volumio[1505]: info: ------------------------------------------- Jan 11 17:55:27 ek-musica volumio[1505]: info: ----- Core plugins startup ---- Jan 11 17:55:27 ek-musica volumio[1505]: info: ------------------------------------------- Jan 11 17:55:27 ek-musica volumio[1505]: info: Loading plugins from folder /volumio/app/plugins/ Jan 11 17:55:27 ek-musica volumio[1505]: info: Adding plugin upnp to MyMusic Plugins Jan 11 17:55:27 ek-musica volumio[1505]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 11 17:55:27 ek-musica volumio[1505]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 11 17:55:27 ek-musica volumio[1505]: info: Loading plugins from folder /data/plugins/ Jan 11 17:55:27 ek-musica volumio[1505]: info: Loading plugin "system"... Jan 11 17:55:27 ek-musica volumio[1505]: info: Loading plugin "appearance"... Jan 11 17:55:28 ek-musica volumio[1505]: info: Loading plugin "network"... Jan 11 17:55:28 ek-musica volumio[1505]: info: Refreshing Cached IP Addresses Jan 11 17:55:28 ek-musica sudo[1530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 17:55:28 ek-musica volumio[1505]: info: Loading plugin "services"... Jan 11 17:55:28 ek-musica sudo[1530]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:28 ek-musica volumio[1505]: info: Loading plugin "alsa_controller"... Jan 11 17:55:28 ek-musica sudo[1530]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:28 ek-musica sudo[1533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 17:55:28 ek-musica sudo[1533]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:28 ek-musica sudo[1533]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:28 ek-musica volumio[1505]: info: Loading plugin "wizard"... Jan 11 17:55:28 ek-musica volumio[1505]: info: Loading plugin "volumio_command_line_client"... Jan 11 17:55:28 ek-musica volumio[1505]: info: Loading plugin "upnp"... Jan 11 17:55:28 ek-musica volumio[1505]: info: [1736618128869] Starting Upmpd Daemon Jan 11 17:55:28 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 11 17:55:28 ek-musica volumio[1505]: info: Loading plugin "my_music"... Jan 11 17:55:28 ek-musica volumio[1505]: info: Loading plugin "mpd"... Jan 11 17:55:29 ek-musica volumio[1505]: info: Loading plugin "upnp_browser"... Jan 11 17:55:29 ek-musica volumio[1505]: info: Loading plugin "networkfs"... Jan 11 17:55:29 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 11 17:55:29 ek-musica volumio[1505]: info: Loading plugin "alarm-clock"... Jan 11 17:55:29 ek-musica volumio[1505]: info: Loading plugin "airplay_emulation"... Jan 11 17:55:29 ek-musica volumio[1505]: info: Starting Shairport Sync Jan 11 17:55:29 ek-musica volumio[1505]: info: Loading plugin "last_100"... Jan 11 17:55:29 ek-musica volumio[1505]: info: Loading plugin "webradio"... Jan 11 17:55:29 ek-musica volumio[1505]: info: Loading plugin "i2s_dacs"... Jan 11 17:55:30 ek-musica volumio[1505]: info: I2S DAC not set, start Auto-detection Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "volumiodiscovery"... Jan 11 17:55:30 ek-musica volumio-remote-updater[593]: [2025-01-11 17:55:30] [connect] Successful connection Jan 11 17:55:30 ek-musica volumio[1505]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 11 17:55:30 ek-musica node[1505]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 11 17:55:30 ek-musica node[1505]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 17:55:30 ek-musica node[1505]: *** WARNING *** For more information see Jan 11 17:55:30 ek-musica node[1505]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 11 17:55:30 ek-musica node[1505]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 17:55:30 ek-musica node[1505]: *** WARNING *** For more information see Jan 11 17:55:30 ek-musica volumio[1505]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 17:55:30 ek-musica volumio[1505]: *** WARNING *** For more information see Jan 11 17:55:30 ek-musica volumio[1505]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 11 17:55:30 ek-musica volumio[1505]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 17:55:30 ek-musica volumio[1505]: *** WARNING *** For more information see Jan 11 17:55:30 ek-musica volumio[1505]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 11 17:55:30 ek-musica volumio[1505]: Discovery: StartAdv! undefined Jan 11 17:55:30 ek-musica volumio[1505]: Discovery: Started advertising... ek-musica - undefined Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "auto_play"... Jan 11 17:55:30 ek-musica volumio[1505]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "autostart"... Jan 11 17:55:30 ek-musica volumio[1505]: info: Applying required configuration parameters for plugin autostart Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "outputs"... Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "albumart"... Jan 11 17:55:30 ek-musica volumio[1505]: info: Plugin example_plugin is not enabled Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "inputs"... Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "updater_comm"... Jan 11 17:55:30 ek-musica volumio[1505]: info: Plugin mpdemulation is not enabled Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "rest_api"... Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading plugin "websocket"... Jan 11 17:55:30 ek-musica volumio[1505]: info: ___________ START PLUGINS ___________ Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 17:55:30 ek-musica volumio[1505]: info: [1736618130522] CoreMusicLibrary::Adding element Media Servers Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:30 ek-musica volumio[1505]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 11 17:55:30 ek-musica volumio[1505]: Forking 3 albumart workers Jan 11 17:55:30 ek-musica volumio[1505]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 17:55:30 ek-musica volumio[1505]: info: [1736618130637] CoreMusicLibrary::Adding element Last_100 Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 17:55:30 ek-musica volumio[1505]: info: [1736618130642] CoreMusicLibrary::Adding element Webradio Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 11 17:55:30 ek-musica volumio[1505]: info: ------------------------------------------- Jan 11 17:55:30 ek-musica volumio[1505]: info: ----- MyVolumio plugins startup ---- Jan 11 17:55:30 ek-musica volumio[1505]: info: ------------------------------------------- Jan 11 17:55:30 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 11 17:55:30 ek-musica volumio[1505]: info: Loading i18n strings for locale es Jan 11 17:55:30 ek-musica volumio[1505]: Updating browse sources language Jan 11 17:55:30 ek-musica volumio[1505]: Cannot find translation for sourceMedia Servers Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::initPlayerControls Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 17:55:30 ek-musica volumio[1505]: info: BOOT COMPLETED Jan 11 17:55:30 ek-musica volumio[1505]: [Metrics] CommandRouter: 3s 996.81ms Jan 11 17:55:30 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:31 ek-musica volumio[1505]: Starting albumart workers Jan 11 17:55:31 ek-musica volumio[1505]: Starting albumart workers Jan 11 17:55:31 ek-musica volumio[1505]: Starting albumart workers Jan 11 17:55:36 ek-musica volumio[1505]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::Close All Modals sent Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::Close All Modals sent Jan 11 17:55:36 ek-musica volumio[1505]: Express server listening on port 3000 Jan 11 17:55:36 ek-musica volumio[1505]: [Metrics] WebUI: 9s 754.92ms Jan 11 17:55:36 ek-musica volumio[1505]: Volumio Calling Home Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::resetVolumioState Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::getcurrentVolume Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::volumioRetrievevolume Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 17:55:36 ek-musica volumio[1505]: info: Setting Device type: Raspberry PI Jan 11 17:55:36 ek-musica volumio[1505]: info: MPD running with PID690 Jan 11 17:55:36 ek-musica volumio[1505]: ,establishing connection Jan 11 17:55:36 ek-musica sudo[1626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jan 11 17:55:36 ek-musica sudo[1626]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:36 ek-musica sudo[1626]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:36 ek-musica volumio[1505]: info: VolumeController:: Volume=100 Mute =false Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::pushState Jan 11 17:55:36 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::updateTrackBlock Jan 11 17:55:36 ek-musica volumio[1505]: info: CorePlayQueue::getTrackBlock Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::volumioRetrievevolume Jan 11 17:55:36 ek-musica volumio[1505]: error: error Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:36 ek-musica volumio[1505]: info: Reloading queue from file Jan 11 17:55:36 ek-musica volumio[1505]: error: Failed LSINFO: Error: [50@0] {} No such directory Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::setRepeat true single undefined Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::pushState Jan 11 17:55:36 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::setRandom true Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::pushState Jan 11 17:55:36 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:36 ek-musica volumio[1505]: info: VolumeController:: Volume=100 Mute =false Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreStateMachine::pushState Jan 11 17:55:36 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:36 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:36 ek-musica volumio[1505]: info: Starting Shairport Sync Jan 11 17:55:36 ek-musica volumio[1505]: info: Starting Shairport Sync Jan 11 17:55:36 ek-musica sudo[1638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 11 17:55:36 ek-musica sudo[1638]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:36 ek-musica sudo[1641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 11 17:55:36 ek-musica systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 11 17:55:36 ek-musica sudo[1641]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:36 ek-musica systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 11 17:55:36 ek-musica systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 11 17:55:36 ek-musica sudo[1638]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:36 ek-musica systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 11 17:55:36 ek-musica systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 11 17:55:36 ek-musica systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 11 17:55:36 ek-musica sudo[1641]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:37 ek-musica volumio[1505]: Discovery: adding a51ef31c-7c06-4685-b34f-2fde1e442189 Jan 11 17:55:37 ek-musica volumio[1505]: info: mDNS: Found device ek-musica Jan 11 17:55:37 ek-musica volumio[1505]: info: CoreCommandRouter::volumioGetState Jan 11 17:55:37 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:37 ek-musica volumio[1505]: info: Shairport-Sync Started Jan 11 17:55:37 ek-musica volumio[1505]: Error adding Membership: Error: addMembership EINVAL Jan 11 17:55:37 ek-musica volumio[1505]: info: Shairport-Sync Started Jan 11 17:55:37 ek-musica volumio[1505]: info: ControllerAutoPlay - mpd ready Jan 11 17:55:37 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 11 17:55:37 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 11 17:55:37 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 11 17:55:37 ek-musica volumio[1505]: info: CoreCommandRouter::volumioGetState Jan 11 17:55:37 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:38 ek-musica sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 17:55:38 ek-musica sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:38 ek-musica sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 17:55:38 ek-musica sudo[1675]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:38 ek-musica sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:38 ek-musica sudo[1677]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:38 ek-musica sudo[1690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 11 17:55:38 ek-musica sudo[1690]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:38 ek-musica systemd[1]: Started UPnP Renderer front-end to MPD. Jan 11 17:55:38 ek-musica sudo[1690]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:38 ek-musica volumio[1505]: info: Upmpdcli Daemon Started Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 11 17:55:38 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 11 17:55:39 ek-musica volumio[1505]: info: Adding plugin bluetooth to MyMusic Plugins Jan 11 17:55:39 ek-musica volumio[1505]: info: Adding plugin cd_controller to MyMusic Plugins Jan 11 17:55:39 ek-musica volumio[1505]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 11 17:55:39 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 11 17:55:40 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 11 17:55:41 ek-musica volumio[1505]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 11 17:55:41 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 11 17:55:41 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:41 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 17:55:41 ek-musica volumio[1505]: info: Starting MyVolumio Remote Streaming Endpoints Jan 11 17:55:41 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 11 17:55:41 ek-musica volumio[1505]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 11 17:55:41 ek-musica volumio[1505]: info: Streaming services startup Jan 11 17:55:41 ek-musica volumio[1505]: info: Starting Streaming Daemon Jan 11 17:55:41 ek-musica sudo[1702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 11 17:55:41 ek-musica sudo[1702]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 11 17:55:41 ek-musica systemd[1]: Stopping Volumio Streaming Daemon... Jan 11 17:55:41 ek-musica volumio[1505]: info: MyVolumio not started Jan 11 17:55:41 ek-musica volumio[1505]: info: Initializing device activation check Jan 11 17:55:41 ek-musica systemd[1]: Starting Volumio Streaming Daemon... Jan 11 17:55:41 ek-musica systemd[1]: Started Volumio Streaming Daemon. Jan 11 17:55:41 ek-musica sudo[1702]: pam_unix(sudo:session): session closed for user root Jan 11 17:55:41 ek-musica volumio-streaming-daemon[1712]: ############################ Jan 11 17:55:41 ek-musica volumio-streaming-daemon[1712]: # Volumio Streaming Daemon # Jan 11 17:55:41 ek-musica volumio-streaming-daemon[1712]: # Running on port 7777 # Jan 11 17:55:41 ek-musica volumio-streaming-daemon[1712]: ############################ Jan 11 17:55:41 ek-musica volumio-streaming-daemon[1712]: Environment: production Jan 11 17:55:41 ek-musica volumio[1505]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 11 17:55:42 ek-musica volumio[1505]: info: ControllerAutoPlay - getting queue Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::volumioGetQueue Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::getQueue Jan 11 17:55:42 ek-musica volumio[1505]: info: CorePlayQueue::getQueue Jan 11 17:55:42 ek-musica volumio[1505]: info: ControllerAutoPlay - start playing -> queue is not empty Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPlay Jan 11 17:55:42 ek-musica volumio[1505]: UNSET VOLATILE Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::play index undefined Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 17:55:42 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::startPlaybackTimer Jan 11 17:55:42 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/christmas/christmas (115).mp3 Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 17:55:42 ek-musica volumio[1505]: info: Jan 11 17:55:42 ek-musica volumio[1505]: ---------------------------- MPD announces state update: player Jan 11 17:55:42 ek-musica volumio[1505]: info: ControllerMpd::getState Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 17:55:42 ek-musica volumio[1505]: info: Jan 11 17:55:42 ek-musica volumio[1505]: ---------------------------- MPD announces system playlist update Jan 11 17:55:42 ek-musica volumio[1505]: info: Ignoring MPD Status Update Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::parseState Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/christmas/christmas (115).mp3" Jan 11 17:55:42 ek-musica volumio[1505]: error: updateQueue error: null Jan 11 17:55:42 ek-musica volumio[1505]: info: Jan 11 17:55:42 ek-musica volumio[1505]: ---------------------------- MPD announces system playlist update Jan 11 17:55:42 ek-musica volumio[1505]: info: Ignoring MPD Status Update Jan 11 17:55:42 ek-musica volumio[1505]: info: ------------------------------ 11ms Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::parseTrackInfo Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand play Jan 11 17:55:42 ek-musica volumio[1505]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 17:55:42 ek-musica volumio[1505]: info: ------------------------------ 26ms Jan 11 17:55:42 ek-musica volumio[1505]: info: ------------------------------ 11ms Jan 11 17:55:42 ek-musica volumio[1505]: info: Jan 11 17:55:42 ek-musica volumio[1505]: ---------------------------- MPD announces state update: player Jan 11 17:55:42 ek-musica volumio[1505]: info: ControllerMpd::getState Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:55:42 ek-musica volumio[1505]: info: Jan 11 17:55:42 ek-musica volumio[1505]: ---------------------------- MPD announces state update: player Jan 11 17:55:42 ek-musica volumio[1505]: info: ControllerMpd::getState Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::parseState Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::parseState Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::parseTrackInfo Jan 11 17:55:42 ek-musica volumio[1505]: info: ControllerMpd::pushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::servicePushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:42 ek-musica volumio[1505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":405,"duration":167,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"2000 Miles","artist":"GRACEY","album":"2000 Miles","uri":"INTERNAL/christmas/christmas (115).mp3","trackType":"mp3"} Jan 11 17:55:42 ek-musica volumio[1505]: verbose: CURRENT POSITION 0 Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::syncState stateService play Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::syncState currentStatus stop Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::pushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:42 ek-musica volumio[1505]: info: ------------------------------ 28ms Jan 11 17:55:42 ek-musica volumio[1505]: verbose: ControllerMpd::parseTrackInfo Jan 11 17:55:42 ek-musica volumio[1505]: info: ControllerMpd::pushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::servicePushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:42 ek-musica volumio[1505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":167,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"2000 Miles","artist":"GRACEY","album":"2000 Miles","uri":"INTERNAL/christmas/christmas (115).mp3","trackType":"mp3"} Jan 11 17:55:42 ek-musica volumio[1505]: verbose: CURRENT POSITION 0 Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::syncState stateService play Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::syncState currentStatus play Jan 11 17:55:42 ek-musica volumio[1505]: info: Received an update from plugin. extracting info from payload Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::pushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreStateMachine::pushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPushState Jan 11 17:55:42 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:55:42 ek-musica volumio[1505]: info: ------------------------------ 42ms Jan 11 17:55:42 ek-musica volumio-remote-updater[593]: [2025-01-11 17:55:42] [connect] Successful connection Jan 11 17:55:42 ek-musica volumio-remote-updater[593]: [2025-01-11 17:55:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1736618142 101 Jan 11 17:55:44 ek-musica volumio-streaming-daemon[1712]: Environment: production Jan 11 17:55:44 ek-musica volumio[1505]: info: Fetching Streaming Services browse cache Jan 11 17:55:44 ek-musica volumio[1505]: info: CoreCommandRouter::volumioGetVisibleSources Jan 11 17:55:44 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:55:44 ek-musica volumio[1505]: info: CoreCommandRouter::volumioGetState Jan 11 17:55:44 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:44 ek-musica volumio[1505]: info: CoreCommandRouter::volumioGetQueue Jan 11 17:55:44 ek-musica volumio[1505]: info: CoreStateMachine::getQueue Jan 11 17:55:44 ek-musica volumio[1505]: info: CorePlayQueue::getQueue Jan 11 17:55:44 ek-musica volumio[1505]: info: Listing playlists Jan 11 17:55:44 ek-musica volumio[1505]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 11 17:55:45 ek-musica volumio[1505]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Ronettes/A%20Christmas%20Gift%20For%20You%20From%20Phil%20Spector/813094ce-f2ae-4a06-aa9c-ffa846f566ad.png' Jan 11 17:55:45 ek-musica volumio[1505]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Darlene%20Love/A%20Christmas%20Gift%20For%20You%20From%20Phil%20Spector/8d9142cb-e31f-4761-b1c7-36d9dba06e35.png' Jan 11 17:55:45 ek-musica volumio[1505]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Frank%20Sinatra/A%20Jolly%20Christmas%20From%20Frank%20Sinatra/55e224a8-8801-4e9c-9f3f-f19e6f8d64c5.jpg' Jan 11 17:55:46 ek-musica volumio[1505]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=b1c450b1438bce6d2cf19261a5df4b24" http://updates.volumio.org:7070/downloader-v1/track-device Jan 11 17:55:46 ek-musica volumio[1505]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 11 17:55:46 ek-musica volumio[1505]: Dload Upload Total Spent Left Speed Jan 11 17:55:46 ek-musica volumio[1505]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 11 17:55:46 ek-musica volumio[1505]: retrying in 5 seconds, trial 0 Jan 11 17:55:46 ek-musica volumio[1505]: Volumio Calling Home Jan 11 17:55:46 ek-musica CRON[1732]: pam_unix(cron:session): session opened for user root by (uid=0) Jan 11 17:55:46 ek-musica CRON[1739]: (root) CMD (/home/volumio/volumio.sh 2> /home/volumio/cron.log) Jan 11 17:55:46 ek-musica volumio[1505]: info: CoreCommandRouter::volumioGetState Jan 11 17:55:46 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:47 ek-musica CRON[1732]: pam_unix(cron:session): session closed for user root Jan 11 17:55:50 ek-musica volumio[1505]: info: AutoStart - getting queue Jan 11 17:55:50 ek-musica volumio[1505]: info: CoreCommandRouter::volumioGetQueue Jan 11 17:55:50 ek-musica volumio[1505]: info: CoreStateMachine::getQueue Jan 11 17:55:50 ek-musica volumio[1505]: info: CorePlayQueue::getQueue Jan 11 17:55:50 ek-musica volumio[1505]: info: AutoStart - start playing -> queue is not empty Jan 11 17:55:50 ek-musica volumio[1505]: info: CoreCommandRouter::volumioPlay Jan 11 17:55:50 ek-musica volumio[1505]: UNSET VOLATILE Jan 11 17:55:50 ek-musica volumio[1505]: info: CoreStateMachine::play index undefined Jan 11 17:55:50 ek-musica volumio[1505]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 17:55:50 ek-musica volumio[1505]: info: CorePlayQueue::getTrack 0 Jan 11 17:55:56 ek-musica volumio[1505]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.861&uuid=b1c450b1438bce6d2cf19261a5df4b24" http://updates.volumio.org:7070/downloader-v1/track-device Jan 11 17:55:56 ek-musica volumio[1505]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 11 17:55:56 ek-musica volumio[1505]: Dload Upload Total Spent Left Speed Jan 11 17:55:56 ek-musica volumio[1505]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 11 17:55:56 ek-musica volumio[1505]: retrying in 5 seconds, trial 1 Jan 11 17:55:56 ek-musica volumio[1505]: Volumio Calling Home Jan 11 17:55:57 ek-musica volumio[1505]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 17:55:57 ek-musica volumio[1505]: { Error: read ECONNRESET Jan 11 17:55:57 ek-musica volumio[1505]: at _errnoException (util.js:1022:11) Jan 11 17:55:57 ek-musica volumio[1505]: at TLSWrap.onread (net.js:628:25) code: 'ECONNRESET', errno: 'ECONNRESET', syscall: 'read' } Jan 11 17:55:57 ek-musica volumio[1505]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 17:55:58 ek-musica sudo[1804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-11 17:54 Jan 11 17:55:58 ek-musica sudo[1804]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 14:39:52 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="097e28ee6263e31d0bf6b690a02dcab3"