-- Logs begin at Wed 2025-02-12 21:20:19 UTC, end at Sat 2025-02-22 21:22:35 UTC. -- Feb 22 21:21:00 volumio2 volumio[785]: info: Loading plugin "network"... Feb 22 21:21:00 volumio2 volumio-remote-updater[518]: [2025-02-22 21:21:00] [connect] Successful connection Feb 22 21:21:02 volumio2 volumio[785]: info: Loading plugin "services"... Feb 22 21:21:02 volumio2 volumio[785]: info: Loading plugin "alsa_controller"... Feb 22 21:21:02 volumio2 volumio[785]: info: Loading plugin "wizard"... Feb 22 21:21:02 volumio2 volumio[785]: info: Loading plugin "volumio_command_line_client"... Feb 22 21:21:03 volumio2 volumio[785]: info: Loading plugin "upnp"... Feb 22 21:21:03 volumio2 volumio[785]: info: [1740259263110] Starting Upmpd Daemon Feb 22 21:21:03 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 21:21:03 volumio2 volumio[785]: info: Loading plugin "my_music"... Feb 22 21:21:03 volumio2 volumio[785]: info: Loading plugin "mpd"... Feb 22 21:21:05 volumio2 volumio[785]: info: Loading plugin "upnp_browser"... Feb 22 21:21:09 volumio2 volumio[785]: info: Loading plugin "networkfs"... Feb 22 21:21:09 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 21:21:09 volumio2 volumio[785]: info: Loading plugin "alarm-clock"... Feb 22 21:21:11 volumio2 volumio[785]: info: Loading plugin "airplay_emulation"... Feb 22 21:21:11 volumio2 volumio[785]: info: Starting Shairport Sync Feb 22 21:21:11 volumio2 volumio[785]: info: Loading plugin "last_100"... Feb 22 21:21:11 volumio2 volumio[785]: info: Loading plugin "webradio"... Feb 22 21:21:11 volumio2 volumio[785]: info: Loading plugin "i2s_dacs"... Feb 22 21:21:12 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 21:21:12 volumio2 volumio[785]: info: Loading plugin "volumiodiscovery"... Feb 22 21:21:12 volumio2 volumio[785]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 22 21:21:12 volumio2 node[785]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 22 21:21:12 volumio2 node[785]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 21:21:12 volumio2 node[785]: *** WARNING *** For more information see Feb 22 21:21:12 volumio2 node[785]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 22 21:21:12 volumio2 node[785]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 21:21:12 volumio2 node[785]: *** WARNING *** For more information see Feb 22 21:21:12 volumio2 volumio[785]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 21:21:12 volumio2 volumio[785]: *** WARNING *** For more information see Feb 22 21:21:12 volumio2 volumio[785]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 22 21:21:12 volumio2 volumio[785]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 21:21:12 volumio2 volumio[785]: *** WARNING *** For more information see Feb 22 21:21:12 volumio2 volumio[785]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 22 21:21:12 volumio2 volumio[785]: Discovery: StartAdv! undefined Feb 22 21:21:12 volumio2 volumio[785]: Discovery: Started advertising... Volumio2 - undefined Feb 22 21:21:12 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 21:21:12 volumio2 volumio[785]: info: Loading plugin "outputs"... Feb 22 21:21:12 volumio2 volumio[785]: info: Loading plugin "albumart"... Feb 22 21:21:12 volumio2 volumio[785]: info: Plugin example_plugin is not enabled Feb 22 21:21:12 volumio2 volumio[785]: info: Loading plugin "inputs"... Feb 22 21:21:12 volumio2 volumio[785]: info: Loading plugin "updater_comm"... Feb 22 21:21:14 volumio2 volumio[785]: info: Plugin mpdemulation is not enabled Feb 22 21:21:14 volumio2 volumio[785]: info: Loading plugin "rest_api"... Feb 22 21:21:15 volumio2 volumio[785]: info: Loading plugin "websocket"... Feb 22 21:21:15 volumio2 volumio[785]: info: ___________ START PLUGINS ___________ Feb 22 21:21:15 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 21:21:15 volumio2 volumio[785]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 21:21:15 volumio2 volumio[785]: info: [1740259275854] CoreMusicLibrary::Adding element Media Servers Feb 22 21:21:15 volumio2 volumio-remote-updater[518]: [2025-02-22 21:21:15] [connect] Successful connection Feb 22 21:21:15 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 21:21:16 volumio2 volumio[785]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 21:21:16 volumio2 volumio[785]: Forking 1 albumart workers Feb 22 21:21:17 volumio2 volumio[785]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 21:21:17 volumio2 volumio[785]: info: [1740259277032] CoreMusicLibrary::Adding element Last_100 Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 21:21:17 volumio2 volumio[785]: info: [1740259277107] CoreMusicLibrary::Adding element Webradio Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 21:21:17 volumio2 volumio[785]: info: ------------------------------------------- Feb 22 21:21:17 volumio2 volumio[785]: info: ----- MyVolumio plugins startup ---- Feb 22 21:21:17 volumio2 volumio[785]: info: ------------------------------------------- Feb 22 21:21:17 volumio2 volumio[785]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 22 21:21:17 volumio2 volumio[785]: info: Loading i18n strings for locale en Feb 22 21:21:17 volumio2 volumio[785]: Updating browse sources language Feb 22 21:21:17 volumio2 volumio[785]: Cannot find translation for sourceMedia Servers Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::initPlayerControls Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 21:21:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 22 21:21:18 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 21:21:18 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 21:21:18 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 21:21:18 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 21:21:18 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 21:21:18 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 21:21:18 volumio2 volumio[785]: info: BOOT COMPLETED Feb 22 21:21:18 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 21:21:18 volumio2 kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Feb 22 21:21:22 volumio2 volumio[785]: Starting albumart workers Feb 22 21:21:24 volumio2 volumio[785]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Feb 22 21:21:24 volumio2 volumio[785]: info: CoreCommandRouter::Close All Modals sent Feb 22 21:21:24 volumio2 volumio[785]: info: CoreCommandRouter::Close All Modals sent Feb 22 21:21:24 volumio2 volumio[785]: Express server listening on port 3000 Feb 22 21:21:24 volumio2 volumio[785]: Volumio Calling Home Feb 22 21:21:25 volumio2 volumio[785]: info: CoreStateMachine::resetVolumioState Feb 22 21:21:25 volumio2 volumio[785]: info: CoreStateMachine::getcurrentVolume Feb 22 21:21:25 volumio2 volumio[785]: info: CoreCommandRouter::volumioRetrievevolume Feb 22 21:21:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 22 21:21:26 volumio2 sudo[1018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:21:26 volumio2 sudo[1018]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:21:26 volumio2 sudo[1018]: pam_unix(sudo:session): session closed for user root Feb 22 21:21:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 22 21:21:27 volumio2 volumio[785]: info: Setting Device type: Raspberry PI Feb 22 21:21:27 volumio2 volumio[785]: error: Cannot initialize MPD Connection: MPD is not running Feb 22 21:21:29 volumio2 volumio[785]: info: Feb 22 21:21:29 volumio2 volumio[785]: ---------------------------- Client requests Volume 80 Feb 22 21:21:29 volumio2 volumio[785]: info: VolumeController::SetAlsaVolume80 Feb 22 21:21:29 volumio2 volumio[785]: info: CoreStateMachine::pushState Feb 22 21:21:29 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:21:29 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:21:29 volumio2 volumio[785]: info: CoreCommandRouter::volumioPushState Feb 22 21:21:29 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 21:21:29 volumio2 volumio[785]: info: VolumeController:: Volume=79 Mute =false Feb 22 21:21:29 volumio2 volumio[785]: info: CoreStateMachine::pushState Feb 22 21:21:29 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:21:29 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:21:29 volumio2 volumio[785]: info: CoreCommandRouter::volumioPushState Feb 22 21:21:29 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 21:21:29 volumio2 volumio[785]: info: CoreStateMachine::updateTrackBlock Feb 22 21:21:29 volumio2 volumio[785]: info: CorePlayQueue::getTrackBlock Feb 22 21:21:29 volumio2 volumio[785]: info: CoreCommandRouter::volumioRetrievevolume Feb 22 21:21:29 volumio2 volumio[785]: info: Reloading queue from file Feb 22 21:21:30 volumio2 volumio[785]: info: Setting volume on startup at 80 Feb 22 21:21:30 volumio2 volumio[785]: info: CoreStateMachine::setRepeat null single undefined Feb 22 21:21:30 volumio2 volumio[785]: info: CoreStateMachine::pushState Feb 22 21:21:30 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:21:30 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:21:30 volumio2 volumio[785]: info: CoreCommandRouter::volumioPushState Feb 22 21:21:30 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 21:21:30 volumio2 volumio[785]: info: CoreStateMachine::setRandom null Feb 22 21:21:30 volumio2 volumio[785]: info: CoreStateMachine::pushState Feb 22 21:21:30 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:21:30 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:21:30 volumio2 volumio[785]: info: CoreCommandRouter::volumioPushState Feb 22 21:21:30 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 21:21:30 volumio2 volumio-remote-updater[518]: [2025-02-22 21:21:30] [connect] Successful connection Feb 22 21:21:31 volumio2 volumio[785]: info: Starting Shairport Sync Feb 22 21:21:31 volumio2 volumio[785]: info: Starting Shairport Sync Feb 22 21:21:31 volumio2 sudo[1039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 21:21:31 volumio2 sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:21:31 volumio2 sudo[1041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 21:21:31 volumio2 sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:21:31 volumio2 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Feb 22 21:21:31 volumio2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 22 21:21:32 volumio2 sudo[1039]: pam_unix(sudo:session): session closed for user root Feb 22 21:21:32 volumio2 sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 22 21:21:32 volumio2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 22 21:21:32 volumio2 sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:21:32 volumio2 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Feb 22 21:21:32 volumio2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 22 21:21:32 volumio2 sudo[1041]: pam_unix(sudo:session): session closed for user root Feb 22 21:21:32 volumio2 systemd[1]: Starting UPnP Renderer front-end to MPD... Feb 22 21:21:32 volumio2 systemd[1]: Started UPnP Renderer front-end to MPD. Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 22 21:21:32 volumio2 sudo[1043]: pam_unix(sudo:session): session closed for user root Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 22 21:21:32 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 22 21:21:33 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 22 21:21:33 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 22 21:21:33 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 22 21:21:33 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 22 21:21:33 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 22 21:21:33 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 22 21:21:33 volumio2 volumio[785]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 22 21:21:33 volumio2 volumio[785]: info: Adding plugin bluetooth to MyMusic Plugins Feb 22 21:21:33 volumio2 volumio[785]: info: Adding plugin cd_controller to MyMusic Plugins Feb 22 21:21:33 volumio2 volumio[785]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 22 21:21:33 volumio2 volumio[785]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 22 21:21:45 volumio2 volumio-remote-updater[518]: [2025-02-22 21:21:45] [connect] Successful connection Feb 22 21:21:47 volumio2 volumio[785]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 22 21:21:56 volumio2 volumio[785]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 22 21:21:56 volumio2 volumio[785]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 22 21:21:56 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 21:21:56 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 21:21:56 volumio2 volumio[785]: info: Starting MyVolumio Remote Streaming Endpoints Feb 22 21:21:56 volumio2 volumio[785]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 22 21:21:56 volumio2 volumio[785]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 22 21:21:56 volumio2 volumio[785]: info: Streaming services startup Feb 22 21:21:56 volumio2 volumio[785]: info: Starting Streaming Daemon Feb 22 21:21:56 volumio2 volumio[785]: info: MyVolumio not started Feb 22 21:21:56 volumio2 volumio[785]: info: Initializing device activation check Feb 22 21:21:56 volumio2 sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 22 21:21:56 volumio2 sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:21:56 volumio2 systemd[1]: Stopping Volumio Streaming Daemon... Feb 22 21:21:56 volumio2 volumio[785]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 22 21:21:56 volumio2 systemd[1]: Starting Volumio Streaming Daemon... Feb 22 21:21:56 volumio2 systemd[1]: Started Volumio Streaming Daemon. Feb 22 21:21:56 volumio2 sudo[1079]: pam_unix(sudo:session): session closed for user root Feb 22 21:21:57 volumio2 volumio-streaming-daemon[1085]: ############################ Feb 22 21:21:57 volumio2 volumio-streaming-daemon[1085]: # Volumio Streaming Daemon # Feb 22 21:21:57 volumio2 volumio-streaming-daemon[1085]: # Running on port 7777 # Feb 22 21:21:57 volumio2 volumio-streaming-daemon[1085]: ############################ Feb 22 21:21:57 volumio2 volumio[785]: info: VolumeController:: Volume=79 Mute =false Feb 22 21:21:57 volumio2 volumio[785]: info: CoreStateMachine::pushState Feb 22 21:21:57 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:21:57 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:21:57 volumio2 volumio[785]: info: CoreCommandRouter::volumioPushState Feb 22 21:21:57 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 21:21:57 volumio2 volumio[785]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.703&uuid=2d23f5f8e536dcbcdb64d20971349baa" http://updates.volumio.org:7070/downloader-v1/track-device Feb 22 21:21:57 volumio2 volumio[785]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 22 21:21:57 volumio2 volumio[785]: Dload Upload Total Spent Left Speed Feb 22 21:21:57 volumio2 volumio[785]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Feb 22 21:21:57 volumio2 volumio[785]: retrying in 5 seconds, trial 0 Feb 22 21:21:57 volumio2 volumio[785]: Volumio Calling Home Feb 22 21:21:57 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 21:21:57 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 21:21:58 volumio2 volumio[785]: Discovery: adding 2b36e594-d682-4229-a279-4436eb680e29 Feb 22 21:21:58 volumio2 volumio[785]: info: mDNS: Found device Volumio2 Feb 22 21:21:58 volumio2 sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:21:58 volumio2 sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:21:58 volumio2 sudo[1098]: pam_unix(sudo:session): session closed for user root Feb 22 21:21:59 volumio2 systemd[1]: Starting Music Player Daemon... Feb 22 21:22:00 volumio2 volumio[785]: info: Upmpdcli Daemon Started Feb 22 21:22:00 volumio2 volumio[785]: info: Shairport-Sync Started Feb 22 21:22:00 volumio2 volumio[785]: Error adding Membership: Error: addMembership EINVAL Feb 22 21:22:00 volumio2 volumio[785]: info: Shairport-Sync Started Feb 22 21:22:00 volumio2 volumio-remote-updater[518]: [2025-02-22 21:22:00] [connect] Successful connection Feb 22 21:22:02 volumio2 volumio[785]: info: CoreCommandRouter::volumioGetState Feb 22 21:22:02 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:22:02 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:22:02 volumio2 sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:22:02 volumio2 sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:03 volumio2 volumio-remote-updater[518]: [2025-02-22 21:22:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1740259320 101 Feb 22 21:22:03 volumio2 sudo[1110]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:04 volumio2 volumio[785]: info: CoreCommandRouter::volumioGetState Feb 22 21:22:04 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:22:04 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:22:04 volumio2 sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:22:04 volumio2 sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:04 volumio2 sudo[1121]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:06 volumio2 sudo[1133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 21:22:06 volumio2 sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:06 volumio2 sudo[1133]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:06 volumio2 sudo[1135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:22:06 volumio2 sudo[1135]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:06 volumio2 sudo[1135]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:07 volumio2 volumio[785]: info: Fetching Streaming Services browse cache Feb 22 21:22:08 volumio2 volumio[785]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Feb 22 21:22:08 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 21:22:09 volumio2 volumio[785]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Feb 22 21:22:09 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 21:22:11 volumio2 volumio[785]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.703&uuid=2d23f5f8e536dcbcdb64d20971349baa" http://updates.volumio.org:7070/downloader-v1/track-device Feb 22 21:22:11 volumio2 volumio[785]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 22 21:22:11 volumio2 volumio[785]: Dload Upload Total Spent Left Speed Feb 22 21:22:11 volumio2 volumio[785]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Feb 22 21:22:11 volumio2 volumio[785]: retrying in 5 seconds, trial 1 Feb 22 21:22:11 volumio2 volumio[785]: Volumio Calling Home Feb 22 21:22:15 volumio2 systemd[1]: Started Music Player Daemon. Feb 22 21:22:15 volumio2 volumio[785]: Upnp client error: Error: This socket has been ended by the other party Feb 22 21:22:15 volumio2 volumio[785]: Discovery: adding 7ac32f21-75b8-42a0-8017-871f3ef3bec2 Feb 22 21:22:15 volumio2 volumio[785]: info: mDNS: Found device Volumio Feb 22 21:22:16 volumio2 sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:22:16 volumio2 sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:16 volumio2 sudo[1164]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:16 volumio2 volumio[785]: info: CoreCommandRouter::volumioGetState Feb 22 21:22:16 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:22:16 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:22:17 volumio2 sudo[1186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:22:17 volumio2 sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:17 volumio2 sudo[1186]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 21:22:17 volumio2 volumio[785]: info: Listing playlists Feb 22 21:22:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 22 21:22:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 21:22:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 22 21:22:17 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 22 21:22:17 volumio2 volumio[785]: info: CoreCommandRouter::volumioGetState Feb 22 21:22:17 volumio2 volumio[785]: info: CoreStateMachine::getState Feb 22 21:22:17 volumio2 sudo[1194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:22:17 volumio2 volumio[785]: info: CorePlayQueue::getTrack 0 Feb 22 21:22:17 volumio2 sudo[1194]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:17 volumio2 sudo[1194]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:17 volumio2 sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:22:17 volumio2 sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:18 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 21:22:18 volumio2 sudo[1203]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:18 volumio2 sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 21:22:18 volumio2 volumio[785]: info: Listing playlists Feb 22 21:22:18 volumio2 sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 21:22:18 volumio2 sudo[1210]: pam_unix(sudo:session): session closed for user root Feb 22 21:22:23 volumio2 volumio[785]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.703&uuid=2d23f5f8e536dcbcdb64d20971349baa" http://updates.volumio.org:7070/downloader-v1/track-device Feb 22 21:22:23 volumio2 volumio[785]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 22 21:22:23 volumio2 volumio[785]: Dload Upload Total Spent Left Speed Feb 22 21:22:23 volumio2 volumio[785]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Feb 22 21:22:23 volumio2 volumio[785]: retrying in 5 seconds, trial 2 Feb 22 21:22:23 volumio2 volumio[785]: Volumio Calling Home Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::volumioGetBrowseSources Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 22 21:22:26 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 22 21:22:29 volumio2 volumio[785]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Feb 22 21:22:29 volumio2 volumio[785]: info: ControllerMpd::sendMpdCommand rescan Feb 22 21:22:30 volumio2 volumio[785]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 21:22:30 volumio2 volumio[785]: TypeError: Cannot read property 'then' of undefined Feb 22 21:22:30 volumio2 volumio[785]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:347:10) Feb 22 21:22:30 volumio2 volumio[785]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1907:17) Feb 22 21:22:30 volumio2 volumio[785]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1078:29) Feb 22 21:22:30 volumio2 volumio[785]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:986:24) Feb 22 21:22:30 volumio2 volumio[785]: at emitTwo (events.js:126:13) Feb 22 21:22:30 volumio2 volumio[785]: at Socket.emit (events.js:214:7) Feb 22 21:22:30 volumio2 volumio[785]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 22 21:22:30 volumio2 volumio[785]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Feb 22 21:22:30 volumio2 volumio[785]: at process._tickCallback (internal/process/next_tick.js:180:9) Feb 22 21:22:30 volumio2 volumio[785]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 21:22:35 volumio2 sudo[1263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-22 21:21 Feb 22 21:22:35 volumio2 sudo[1263]: 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="7441f93fb55fc13e1243278874bfebef55eaac89" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="60cbd8a1e03b2e464c11c01f54954168a34e9b45" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Feb 15 03:28:59 CET 2020" VOLUMIO_VERSION="2.703" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="c6482eede154d29f2cc010e5a630bcb4"