-- Logs begin at Wed 2025-07-09 14:09:52 UTC, end at Wed 2025-07-09 14:29:39 UTC. -- Jul 09 14:28:00 volumio777 volumio[4167]: info: Starting Shairport Sync Jul 09 14:28:00 volumio777 volumio[4167]: info: Starting Shairport Sync Jul 09 14:28:00 volumio777 sudo[4279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:28:00 volumio777 volumio[4167]: info: Jul 09 14:28:00 volumio777 volumio[4167]: ---------------------------- Client requests Volume 60 Jul 09 14:28:00 volumio777 sudo[4279]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:28:00 volumio777 volumio[4167]: info: VolumeController::SetAlsaVolume60 Jul 09 14:28:00 volumio777 sudo[4282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreStateMachine::pushState Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0 Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:28:00 volumio777 sudo[4282]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:28:00 volumio777 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:28:00 volumio777 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 09 14:28:00 volumio777 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:28:00 volumio777 sudo[4279]: pam_unix(sudo:session): session closed for user root Jul 09 14:28:00 volumio777 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 14:28:00 volumio777 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 09 14:28:00 volumio777 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 14:28:00 volumio777 sudo[4282]: pam_unix(sudo:session): session closed for user root Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0 Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:28:00 volumio777 volumio[4167]: info: Listing playlists Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetQueue Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreStateMachine::getQueue Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getQueue Jul 09 14:28:00 volumio777 volumio[4167]: Discovery: adding d6605900-7e10-43e9-9d31-86def10632a6 Jul 09 14:28:00 volumio777 volumio[4167]: info: mDNS: Found device Volumio777 Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0 Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0 Jul 09 14:28:00 volumio777 volumio[4167]: info: Shairport-Sync Started Jul 09 14:28:00 volumio777 volumio[4167]: Error adding Membership: Error: addMembership EINVAL Jul 09 14:28:00 volumio777 volumio[4167]: info: Shairport-Sync Started Jul 09 14:28:00 volumio777 volumio[4167]: info: Setting volume on startup at 60 Jul 09 14:28:00 volumio777 volumio[4167]: Discovery: this is already registered, d6605900-7e10-43e9-9d31-86def10632a6 Jul 09 14:28:00 volumio777 volumio[4167]: info: mDNS: Found device Volumio777 Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0 Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 14:28:00 volumio777 volumio[4167]: info: Listing playlists Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetQueue Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreStateMachine::getQueue Jul 09 14:28:00 volumio777 volumio[4167]: info: CorePlayQueue::getQueue Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 14:28:00 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:28:00 volumio777 volumio[4167]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bob%20Moses/The%20Silence%20in%20Between/786c2ae6-97c0-442c-a652-01c63c5fdf33.jpg' Jul 09 14:28:01 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:28:01 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:28:01 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 14:28:01 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState Jul 09 14:28:01 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0 Jul 09 14:28:03 volumio777 volumio-remote-updater[689]: [2025-07-09 14:28:03] [connect] Successful connection Jul 09 14:28:03 volumio777 volumio-remote-updater[689]: [2025-07-09 14:28:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1752071283 101 Jul 09 14:28:03 volumio777 sudo[4337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 09 14:28:03 volumio777 sudo[4337]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:28:03 volumio777 sudo[4337]: pam_unix(sudo:session): session closed for user root Jul 09 14:28:03 volumio777 sudo[4340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 09 14:28:03 volumio777 sudo[4346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 09 14:28:03 volumio777 sudo[4340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:28:03 volumio777 sudo[4346]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:28:03 volumio777 sudo[4340]: pam_unix(sudo:session): session closed for user root Jul 09 14:28:03 volumio777 systemd[1]: Started UPnP Renderer front-end to MPD. Jul 09 14:28:03 volumio777 sudo[4346]: pam_unix(sudo:session): session closed for user root Jul 09 14:28:03 volumio777 volumio[4167]: info: Upmpdcli Daemon Started Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 09 14:28:06 volumio777 volumio[4167]: info: Adding plugin bluetooth to MyMusic Plugins Jul 09 14:28:06 volumio777 volumio[4167]: info: Adding plugin cd_controller to MyMusic Plugins Jul 09 14:28:06 volumio777 volumio[4167]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 09 14:28:06 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 09 14:28:09 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 09 14:28:11 volumio777 volumio[4167]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 09 14:28:11 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 09 14:28:11 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:28:11 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:28:11 volumio777 volumio[4167]: info: Starting MyVolumio Remote Streaming Endpoints Jul 09 14:28:11 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 09 14:28:11 volumio777 volumio[4167]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 09 14:28:11 volumio777 volumio[4167]: info: Streaming services startup Jul 09 14:28:11 volumio777 volumio[4167]: info: Starting Streaming Daemon Jul 09 14:28:11 volumio777 volumio[4167]: info: MyVolumio not started Jul 09 14:28:11 volumio777 volumio[4167]: info: Initializing device activation check Jul 09 14:28:11 volumio777 sudo[4369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 09 14:28:12 volumio777 sudo[4369]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 14:28:12 volumio777 systemd[1]: Stopping Volumio Streaming Daemon... Jul 09 14:28:12 volumio777 volumio[4167]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 09 14:28:12 volumio777 systemd[1]: Starting Volumio Streaming Daemon... Jul 09 14:28:12 volumio777 systemd[1]: Started Volumio Streaming Daemon. Jul 09 14:28:12 volumio777 sudo[4369]: pam_unix(sudo:session): session closed for user root Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: ############################ Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: # Volumio Streaming Daemon # Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: # Running on port 7777 # Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: ############################ Jul 09 14:28:12 volumio777 volumio-streaming-daemon[4375]: Environment: production Jul 09 14:28:12 volumio777 volumio[4167]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=4807449e26a8e07c819dc017e00135ac" http://updates.volumio.org:7070/downloader-v1/track-device Jul 09 14:28:12 volumio777 volumio[4167]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 09 14:28:12 volumio777 volumio[4167]: Dload Upload Total Spent Left Speed Jul 09 14:28:12 volumio777 volumio[4167]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jul 09 14:28:12 volumio777 volumio[4167]: retrying in 5 seconds, trial 0 Jul 09 14:28:12 volumio777 volumio[4167]: Volumio Calling Home Jul 09 14:28:14 volumio777 volumio-streaming-daemon[4375]: Environment: production Jul 09 14:28:14 volumio777 volumio[4167]: info: Fetching Streaming Services browse cache Jul 09 14:28:14 volumio777 volumio[4167]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Jul 09 14:28:14 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:28:14 volumio777 volumio[4167]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Jul 09 14:28:14 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 14:28:17 volumio777 volumio[4167]: info: Clearing queue after UPNP request Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::ClearQueue Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::stop Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 14:28:17 volumio777 volumio[4167]: UNSET VOLATILE Jul 09 14:28:17 volumio777 volumio[4167]: info: CorePlayQueue::clearPlayQueue Jul 09 14:28:17 volumio777 volumio[4167]: info: CorePlayQueue::saveQueue Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushQueue Jul 09 14:28:17 volumio777 volumio[4167]: info: Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update Jul 09 14:28:17 volumio777 volumio[4167]: info: Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces state update: player Jul 09 14:28:17 volumio777 volumio[4167]: info: ControllerMpd::getState Jul 09 14:28:17 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand status Jul 09 14:28:17 volumio777 volumio[4167]: info: Starting UPNP Playback Jul 09 14:28:17 volumio777 volumio[4167]: info: Preparing playback through UPNP Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetState Jul 09 14:28:17 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0 Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 09 14:28:17 volumio777 volumio[4167]: error: updateQueue error: null Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 20ms Jul 09 14:28:17 volumio777 volumio[4167]: verbose: ControllerMpd::parseState Jul 09 14:28:17 volumio777 volumio[4167]: info: ControllerMpd::pushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::servicePushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::pushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:28:17 volumio777 volumio[4167]: info: CorePlayQueue::getTrack 0 Jul 09 14:28:17 volumio777 volumio[4167]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 09 14:28:17 volumio777 volumio[4167]: verbose: CURRENT POSITION 0 Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::syncState stateService stop Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::syncState currentStatus stop Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::pushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:28:17 volumio777 volumio[4167]: info: No code Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreStateMachine::pushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState Jul 09 14:28:17 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 86ms Jul 09 14:28:17 volumio777 volumio[4167]: info: Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 7ms Jul 09 14:28:17 volumio777 volumio[4167]: info: Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 4ms Jul 09 14:28:17 volumio777 volumio[4167]: info: Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 4ms Jul 09 14:28:17 volumio777 volumio[4167]: info: Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update Jul 09 14:28:17 volumio777 volumio[4167]: info: Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 6ms Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 5ms Jul 09 14:28:17 volumio777 volumio[4167]: info: Jul 09 14:28:17 volumio777 volumio[4167]: ---------------------------- MPD announces system playlist update Jul 09 14:28:17 volumio777 volumio[4167]: info: Ignoring MPD Status Update Jul 09 14:28:17 volumio777 volumio[4167]: info: ------------------------------ 5ms Jul 09 14:28:18 volumio777 volumio[4167]: info: Jul 09 14:28:18 volumio777 volumio[4167]: ---------------------------- MPD announces state update: player Jul 09 14:28:18 volumio777 volumio[4167]: info: ControllerMpd::getState Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand status Jul 09 14:28:18 volumio777 volumio[4167]: info: Jul 09 14:28:18 volumio777 volumio[4167]: ---------------------------- MPD announces state update: player Jul 09 14:28:18 volumio777 volumio[4167]: info: ControllerMpd::getState Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand status Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::parseState Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::parseState Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::parseTrackInfo Jul 09 14:28:18 volumio777 volumio[4167]: error: ControllerMpd::pushError: TypeError: Cannot read property 'replace' of undefined Jul 09 14:28:18 volumio777 volumio[4167]: info: ------------------------------ 37ms Jul 09 14:28:18 volumio777 volumio[4167]: verbose: ControllerMpd::parseTrackInfo Jul 09 14:28:18 volumio777 volumio[4167]: error: ControllerMpd::pushError: TypeError: Cannot read property 'replace' of undefined Jul 09 14:28:18 volumio777 volumio[4167]: info: ------------------------------ 41ms Jul 09 14:28:22 volumio777 volumio[4167]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=4807449e26a8e07c819dc017e00135ac" http://updates.volumio.org:7070/downloader-v1/track-device Jul 09 14:28:22 volumio777 volumio[4167]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 09 14:28:22 volumio777 volumio[4167]: Dload Upload Total Spent Left Speed Jul 09 14:28:22 volumio777 volumio[4167]: [235B blob data] Jul 09 14:28:22 volumio777 volumio[4167]: retrying in 5 seconds, trial 1 Jul 09 14:28:22 volumio777 volumio[4167]: Volumio Calling Home Jul 09 14:28:27 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 14:28:27 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 14:28:32 volumio777 volumio[4167]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=4807449e26a8e07c819dc017e00135ac" http://updates.volumio.org:7070/downloader-v1/track-device Jul 09 14:28:32 volumio777 volumio[4167]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 09 14:28:32 volumio777 volumio[4167]: Dload Upload Total Spent Left Speed Jul 09 14:28:32 volumio777 volumio[4167]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jul 09 14:28:32 volumio777 volumio[4167]: retrying in 5 seconds, trial 2 Jul 09 14:28:33 volumio777 volumio[4167]: Volumio Calling Home Jul 09 14:28:41 volumio777 volumio[4167]: info: VolumeController::SetAlsaVolume+ Jul 09 14:28:41 volumio777 volumio[4167]: Unable to parse: Jul 09 14:28:41 volumio777 volumio[4167]: Simple mixer control 'SoftMaster',0 Jul 09 14:28:41 volumio777 volumio[4167]: Capabilities: volume Jul 09 14:28:41 volumio777 volumio[4167]: Playback channels: Front Left - Front Right Jul 09 14:28:41 volumio777 volumio[4167]: Capture channels: Front Left - Front Right Jul 09 14:28:41 volumio777 volumio[4167]: Limits: 0 - 99 Jul 09 14:28:41 volumio777 volumio[4167]: Front Left: 59 [60%] Jul 09 14:28:41 volumio777 volumio[4167]: Front Right: 59 [60%] Jul 09 14:28:41 volumio777 volumio[4167]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Jul 09 14:28:41 volumio777 volumio[4167]: info: CoreStateMachine::pushState Jul 09 14:28:41 volumio777 volumio[4167]: info: CoreCommandRouter::volumioPushState Jul 09 14:28:41 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 14:29:01 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:29:01 volumio777 volumio[4167]: info: CURURI: artists:// Jul 09 14:29:09 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:29:09 volumio777 volumio[4167]: info: CURURI: playlists Jul 09 14:29:09 volumio777 volumio[4167]: info: Listing playlists Jul 09 14:29:10 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:29:10 volumio777 volumio[4167]: info: CURURI: music-library Jul 09 14:29:13 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 14:29:13 volumio777 volumio[4167]: info: CURURI: albums:// Jul 09 14:29:13 volumio777 volumio[4167]: listAlbums - loading Albums from cache Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::volumioGetBrowseSources Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 14:29:24 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 09 14:29:28 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 14:29:32 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 14:29:36 volumio777 volumio[4167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 14:29:38 volumio777 volumio[4167]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:29:38 volumio777 volumio[4167]: { Error: connect ETIMEDOUT 148.163.48.215:80 Jul 09 14:29:38 volumio777 volumio[4167]: at Object._errnoException (util.js:1022:11) Jul 09 14:29:38 volumio777 volumio[4167]: at _exceptionWithHostPort (util.js:1044:20) Jul 09 14:29:38 volumio777 volumio[4167]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 09 14:29:38 volumio777 volumio[4167]: code: 'ETIMEDOUT', Jul 09 14:29:38 volumio777 volumio[4167]: errno: 'ETIMEDOUT', Jul 09 14:29:38 volumio777 volumio[4167]: syscall: 'connect', Jul 09 14:29:38 volumio777 volumio[4167]: address: '148.163.48.215', Jul 09 14:29:38 volumio777 volumio[4167]: port: 80 } Jul 09 14:29:38 volumio777 volumio[4167]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 14:29:39 volumio777 sudo[4644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 14:28 Jul 09 14:29:39 volumio777 sudo[4644]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"