-- Logs begin at Fri 2020-12-11 14:53:56 UTC, end at Tue 2025-03-11 14:42:32 UTC. -- Mar 11 14:41:01 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 11 14:41:01 volumio volumio[4976]: info: CoreStateMachine::getcurrentVolume Mar 11 14:41:01 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:41:01 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:01 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:01 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:01 volumio volumio[4976]: info: CoreStateMachine::updateTrackBlock Mar 11 14:41:01 volumio volumio[4976]: info: CorePlayQueue::getTrackBlock Mar 11 14:41:01 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:41:01 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:01 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:01 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:19 volumio volumio[4976]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:19 volumio volumio[4976]: info: Output device has changed, restarting MPD Mar 11 14:41:19 volumio sudo[14338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 11 14:41:19 volumio sudo[14338]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:19 volumio volumio[4976]: info: Output device has changed, restarting Shairport Sync Mar 11 14:41:19 volumio sudo[14338]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:19 volumio sudo[14341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 11 14:41:19 volumio sudo[14341]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:19 volumio systemd[1]: Stopping Music Player Daemon... Mar 11 14:41:19 volumio volumio[4976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:19 volumio systemd[1]: Starting Music Player Daemon... Mar 11 14:41:19 volumio volumio[4976]: info: Setting mixer PCM for card Bose USB Audio Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 11 14:41:19 volumio volumio[4976]: info: Updating Volume Controller Parameters: Device: 1 Name: Bose USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 11 14:41:19 volumio volumio[4976]: info: MPD Permissions set Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 11 14:41:19 volumio volumio[4976]: info: Starting Shairport Sync Mar 11 14:41:19 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:19 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:19 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:19 volumio sudo[14368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 11 14:41:19 volumio sudo[14368]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 11 14:41:19 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 11 14:41:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 11 14:41:19 volumio sudo[14368]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:19 volumio volumio[4976]: info: Shairport-Sync Started Mar 11 14:41:20 volumio systemd[1]: Started Music Player Daemon. Mar 11 14:41:20 volumio sudo[14341]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:20 volumio volumio[4976]: error: updateQueue error: null Mar 11 14:41:21 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 11 14:41:21 volumio volumio[4976]: info: CoreStateMachine::getcurrentVolume Mar 11 14:41:21 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:41:22 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:22 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:22 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:22 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:22 volumio volumio[4976]: info: CoreStateMachine::updateTrackBlock Mar 11 14:41:22 volumio volumio[4976]: info: CorePlayQueue::getTrackBlock Mar 11 14:41:22 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:41:22 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:22 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:22 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:22 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:35 volumio volumio[4976]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:35 volumio volumio[4976]: info: Output device has changed, restarting MPD Mar 11 14:41:35 volumio sudo[14430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 11 14:41:35 volumio sudo[14430]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:35 volumio volumio[4976]: info: Output device has changed, restarting Shairport Sync Mar 11 14:41:35 volumio sudo[14430]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:35 volumio sudo[14432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 11 14:41:35 volumio sudo[14432]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:35 volumio systemd[1]: Stopping Music Player Daemon... Mar 11 14:41:35 volumio volumio[4976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:35 volumio systemd[1]: Starting Music Player Daemon... Mar 11 14:41:35 volumio volumio[4976]: info: Setting mixer PCM for card Bose USB Audio Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 11 14:41:35 volumio volumio[4976]: info: Updating Volume Controller Parameters: Device: 1 Name: Bose USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 11 14:41:35 volumio volumio[4976]: info: MPD Permissions set Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:35 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 11 14:41:36 volumio volumio[4976]: info: Starting Shairport Sync Mar 11 14:41:36 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:36 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:36 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:36 volumio sudo[14458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 11 14:41:36 volumio sudo[14458]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 11 14:41:36 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 11 14:41:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 11 14:41:36 volumio sudo[14458]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:36 volumio volumio[4976]: info: Shairport-Sync Started Mar 11 14:41:36 volumio volumio[4976]: error: Upnp client error: Error: This socket has been ended by the other party Mar 11 14:41:36 volumio sudo[14432]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:36 volumio systemd[1]: Started Music Player Daemon. Mar 11 14:41:36 volumio volumio[4976]: error: updateQueue error: null Mar 11 14:41:38 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 11 14:41:38 volumio volumio[4976]: info: CoreStateMachine::getcurrentVolume Mar 11 14:41:38 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:41:38 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:38 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:38 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:38 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:38 volumio volumio[4976]: info: CoreStateMachine::updateTrackBlock Mar 11 14:41:38 volumio volumio[4976]: info: CorePlayQueue::getTrackBlock Mar 11 14:41:38 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:41:38 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:38 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:38 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:38 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:43 volumio volumio[4976]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:43 volumio volumio[4976]: info: Output device has changed, restarting MPD Mar 11 14:41:43 volumio sudo[14487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 11 14:41:43 volumio sudo[14487]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:43 volumio sudo[14487]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:43 volumio volumio[4976]: info: Output device has changed, restarting Shairport Sync Mar 11 14:41:43 volumio sudo[14490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 11 14:41:43 volumio sudo[14490]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:43 volumio systemd[1]: Stopping Music Player Daemon... Mar 11 14:41:43 volumio volumio[4976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:43 volumio systemd[1]: Starting Music Player Daemon... Mar 11 14:41:43 volumio volumio[4976]: info: Setting mixer PCM for card Bose USB Audio Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 11 14:41:43 volumio volumio[4976]: info: Updating Volume Controller Parameters: Device: 1 Name: Bose USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 11 14:41:43 volumio volumio[4976]: info: MPD Permissions set Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 11 14:41:43 volumio volumio[4976]: info: Starting Shairport Sync Mar 11 14:41:43 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:43 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:43 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:43 volumio sudo[14517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 11 14:41:44 volumio sudo[14517]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:41:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 11 14:41:44 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 11 14:41:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 11 14:41:44 volumio sudo[14517]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:44 volumio volumio[4976]: info: Shairport-Sync Started Mar 11 14:41:44 volumio systemd[1]: Started Music Player Daemon. Mar 11 14:41:44 volumio sudo[14490]: pam_unix(sudo:session): session closed for user root Mar 11 14:41:44 volumio volumio[4976]: error: updateQueue error: null Mar 11 14:41:46 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 11 14:41:46 volumio volumio[4976]: info: CoreStateMachine::getcurrentVolume Mar 11 14:41:46 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:41:46 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:46 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:46 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:46 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:46 volumio volumio[4976]: info: CoreStateMachine::updateTrackBlock Mar 11 14:41:46 volumio volumio[4976]: info: CorePlayQueue::getTrackBlock Mar 11 14:41:46 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:41:46 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:41:46 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:46 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:46 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:55 volumio shairport-sync[14520]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 11 14:41:55 volumio shairport-sync[14520]: Dload Upload Total Spent Left Speed Mar 11 14:41:55 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:55 volumio shairport-sync[14520]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 % Total % Received % Xferd Average Speed Time Time Time Current Mar 11 14:41:55 volumio shairport-sync[14520]: Dload Upload Total Spent Left Speed Mar 11 14:41:55 volumio shairport-sync[14520]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory Mar 11 14:41:55 volumio kernel: 2:1:1: cannot get freq at ep 0x1 Mar 11 14:41:55 volumio volumio[4976]: info: Mar 11 14:41:55 volumio volumio[4976]: ---------------------------- Client requests AirplayActive Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Mar 11 14:41:55 volumio shairport-sync[14520]: 100 57 100 57 0 0 1115 0 --:--:-- --:--:-- --:--:-- 1140 Mar 11 14:41:55 volumio volumio[4976]: info: Mar 11 14:41:55 volumio volumio[4976]: ---------------------------- Client requests Start Airplay PlaybackRoutine Mar 11 14:41:55 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Mar 11 14:41:55 volumio volumio[4976]: info: Airplay playback start Mar 11 14:41:55 volumio kernel: 2:1:1: cannot get freq at ep 0x1 Mar 11 14:41:55 volumio shairport-sync[14520]: [136B blob data] Mar 11 14:41:55 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:41:55 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:41:55 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:41:55 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:41:55 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:41:55 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:41:55 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:41:55 volumio kernel: 2:1:1: cannot get freq at ep 0x1 Mar 11 14:41:55 volumio kernel: 2:1:1: cannot get freq at ep 0x1 Mar 11 14:41:55 volumio kernel: 2:1:1: cannot get freq at ep 0x1 Mar 11 14:41:55 volumio kernel: 2:1:1: cannot get freq at ep 0x1 Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:56 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:41:57 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:41:57 volumio volumio[4976]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Awen/8261c13b-3c90-40b7-8a79-5df46bf00b74.jpg' Mar 11 14:41:59 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 11 14:41:59 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 11 14:41:59 volumio volumio[4976]: info: Discovery: Getting this device information Mar 11 14:41:59 volumio volumio[4976]: info: CoreCommandRouter::volumioGetState Mar 11 14:41:59 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Mar 11 14:41:59 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 11 14:41:59 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 11 14:42:00 volumio volumio[4976]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:00 volumio volumio[4976]: info: Output device has changed, restarting MPD Mar 11 14:42:00 volumio sudo[14564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 11 14:42:00 volumio sudo[14564]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:00 volumio volumio[4976]: info: Output device has changed, restarting Shairport Sync Mar 11 14:42:00 volumio sudo[14564]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:00 volumio sudo[14567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 11 14:42:00 volumio sudo[14567]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:00 volumio systemd[1]: Stopping Music Player Daemon... Mar 11 14:42:00 volumio volumio[4976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:00 volumio volumio[4976]: info: Setting mixer PCM for card Bose USB Audio Mar 11 14:42:00 volumio systemd[1]: Starting Music Player Daemon... Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 11 14:42:00 volumio volumio[4976]: info: Updating Volume Controller Parameters: Device: 1 Name: Bose USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 11 14:42:00 volumio volumio[4976]: info: MPD Permissions set Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 11 14:42:00 volumio volumio[4976]: info: Starting Shairport Sync Mar 11 14:42:00 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:00 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:00 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:00 volumio sudo[14593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 11 14:42:00 volumio sudo[14593]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 11 14:42:00 volumio shairport-sync[14520]: {"time":1741704115792,"response":"startAirplayPlayback Success"} Mar 11 14:42:00 volumio kernel: xhci-hcd xhci-hcd.0.auto: Signal while waiting for configure endpoint command Mar 11 14:42:00 volumio kernel: usb 1-2: Not enough bandwidth for altsetting 0 Mar 11 14:42:00 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 11 14:42:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 11 14:42:00 volumio sudo[14593]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:00 volumio volumio[4976]: info: Shairport-Sync Started Mar 11 14:42:01 volumio volumio[4976]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:01 volumio volumio[4976]: info: Output device has changed, restarting MPD Mar 11 14:42:01 volumio volumio[4976]: info: Output device has changed, restarting Shairport Sync Mar 11 14:42:01 volumio sudo[14611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 11 14:42:01 volumio sudo[14611]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:01 volumio systemd[1]: Stopping Music Player Daemon... Mar 11 14:42:01 volumio sudo[14610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 11 14:42:01 volumio sudo[14610]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:01 volumio sudo[14610]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:01 volumio volumio[4976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:01 volumio systemd[1]: Starting Music Player Daemon... Mar 11 14:42:01 volumio volumio[4976]: info: Setting mixer PCM for card Bose USB Audio Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 11 14:42:01 volumio volumio[4976]: info: Updating Volume Controller Parameters: Device: 1 Name: Bose USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 11 14:42:01 volumio volumio[4976]: info: MPD Permissions set Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 11 14:42:01 volumio volumio[4976]: info: Starting Shairport Sync Mar 11 14:42:01 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:01 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:01 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:01 volumio sudo[14639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 11 14:42:01 volumio sudo[14639]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:01 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 11 14:42:01 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 11 14:42:01 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 11 14:42:01 volumio sudo[14639]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:01 volumio volumio[4976]: info: Shairport-Sync Started Mar 11 14:42:02 volumio systemd[1]: Started Music Player Daemon. Mar 11 14:42:02 volumio sudo[14611]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:02 volumio sudo[14567]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:02 volumio volumio[4976]: error: MPD error: false == true Mar 11 14:42:02 volumio volumio[4976]: error: updateQueue error: null Mar 11 14:42:02 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 11 14:42:02 volumio volumio[4976]: info: CoreStateMachine::getcurrentVolume Mar 11 14:42:02 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:42:03 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:03 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:03 volumio volumio[4976]: info: CoreStateMachine::updateTrackBlock Mar 11 14:42:03 volumio volumio[4976]: info: CorePlayQueue::getTrackBlock Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:42:03 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:03 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 11 14:42:03 volumio volumio[4976]: info: CoreStateMachine::getcurrentVolume Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:42:03 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:03 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:03 volumio volumio[4976]: info: CoreStateMachine::updateTrackBlock Mar 11 14:42:03 volumio volumio[4976]: info: CorePlayQueue::getTrackBlock Mar 11 14:42:03 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:42:03 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:03 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:04 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:04 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:05 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 11 14:42:05 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 11 14:42:05 volumio volumio[4976]: info: Discovery: Getting this device information Mar 11 14:42:05 volumio volumio[4976]: info: CoreCommandRouter::volumioGetState Mar 11 14:42:05 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Mar 11 14:42:05 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 11 14:42:05 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 11 14:42:07 volumio volumio[4976]: error: updateQueue error: null Mar 11 14:42:10 volumio volumio[4976]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:10 volumio volumio[4976]: info: Output device has changed, restarting MPD Mar 11 14:42:10 volumio sudo[14676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 11 14:42:10 volumio sudo[14676]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:10 volumio volumio[4976]: info: Output device has changed, restarting Shairport Sync Mar 11 14:42:10 volumio sudo[14676]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:10 volumio sudo[14679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 11 14:42:10 volumio sudo[14679]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:10 volumio systemd[1]: Stopping Music Player Daemon... Mar 11 14:42:10 volumio volumio[4976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 11 14:42:10 volumio systemd[1]: Starting Music Player Daemon... Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:10 volumio volumio[4976]: info: Setting mixer PCM for card Bose USB Audio Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 11 14:42:10 volumio volumio[4976]: info: Updating Volume Controller Parameters: Device: 1 Name: Bose USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 11 14:42:10 volumio volumio[4976]: info: MPD Permissions set Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 11 14:42:10 volumio volumio[4976]: error: Upnp client error: Error: This socket has been ended by the other party Mar 11 14:42:10 volumio volumio[4976]: info: Starting Shairport Sync Mar 11 14:42:10 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:10 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:10 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:10 volumio sudo[14706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 11 14:42:10 volumio sudo[14706]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 11 14:42:10 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 11 14:42:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 11 14:42:10 volumio sudo[14706]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:10 volumio volumio[4976]: info: Shairport-Sync Started Mar 11 14:42:10 volumio sudo[14679]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:10 volumio systemd[1]: Started Music Player Daemon. Mar 11 14:42:10 volumio volumio[4976]: error: updateQueue error: null Mar 11 14:42:11 volumio volumio[4976]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:11 volumio volumio[4976]: info: Output device has changed, restarting MPD Mar 11 14:42:11 volumio sudo[14726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 11 14:42:11 volumio sudo[14726]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:11 volumio volumio[4976]: info: Output device has changed, restarting Shairport Sync Mar 11 14:42:11 volumio sudo[14726]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:11 volumio sudo[14729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 11 14:42:11 volumio sudo[14729]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:11 volumio systemd[1]: Stopping Music Player Daemon... Mar 11 14:42:11 volumio volumio[4976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:11 volumio volumio[4976]: info: Setting mixer PCM for card Bose USB Audio Mar 11 14:42:11 volumio systemd[1]: Starting Music Player Daemon... Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 11 14:42:11 volumio volumio[4976]: info: Updating Volume Controller Parameters: Device: 1 Name: Bose USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 11 14:42:11 volumio volumio[4976]: info: MPD Permissions set Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 11 14:42:11 volumio volumio[4976]: info: Starting Shairport Sync Mar 11 14:42:11 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:11 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:11 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:11 volumio sudo[14756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 11 14:42:11 volumio sudo[14756]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 11 14:42:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 11 14:42:11 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 11 14:42:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 11 14:42:11 volumio sudo[14756]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:11 volumio volumio[4976]: info: Shairport-Sync Started Mar 11 14:42:11 volumio volumio[4976]: (node:4976) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added. Use emitter.setMaxListeners() to increase limit Mar 11 14:42:11 volumio volumio[4976]: (node:4976) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added. Use emitter.setMaxListeners() to increase limit Mar 11 14:42:11 volumio volumio[4976]: (node:4976) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added. Use emitter.setMaxListeners() to increase limit Mar 11 14:42:11 volumio volumio[4976]: (node:4976) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added. Use emitter.setMaxListeners() to increase limit Mar 11 14:42:11 volumio volumio[4976]: (node:4976) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added. Use emitter.setMaxListeners() to increase limit Mar 11 14:42:12 volumio systemd[1]: Started Music Player Daemon. Mar 11 14:42:12 volumio sudo[14729]: pam_unix(sudo:session): session closed for user root Mar 11 14:42:12 volumio volumio[4976]: error: updateQueue error: null Mar 11 14:42:12 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 11 14:42:12 volumio volumio[4976]: info: CoreStateMachine::getcurrentVolume Mar 11 14:42:12 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:42:12 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:12 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:12 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:12 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:12 volumio volumio[4976]: info: CoreStateMachine::updateTrackBlock Mar 11 14:42:12 volumio volumio[4976]: info: CorePlayQueue::getTrackBlock Mar 11 14:42:12 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:42:13 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:13 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:13 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:13 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:13 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 11 14:42:13 volumio volumio[4976]: info: CoreStateMachine::getcurrentVolume Mar 11 14:42:13 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:42:14 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:14 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:14 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:14 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:14 volumio volumio[4976]: info: CoreStateMachine::updateTrackBlock Mar 11 14:42:14 volumio volumio[4976]: info: CorePlayQueue::getTrackBlock Mar 11 14:42:14 volumio volumio[4976]: info: CoreCommandRouter::volumioRetrievevolume Mar 11 14:42:14 volumio volumio[4976]: info: VolumeController:: Volume=0 Mute =false Mar 11 14:42:14 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:14 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:14 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:24 volumio shairport-sync[14759]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory Mar 11 14:42:24 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI xhci_drop_endpoint called with disabled ep ffffffc051d99880 Mar 11 14:42:24 volumio kernel: xhci-hcd xhci-hcd.0.auto: Trying to add endpoint 0x1 without dropping it. Mar 11 14:42:24 volumio shairport-sync[14759]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 11 14:42:24 volumio shairport-sync[14759]: Dload Upload Total Spent Left Speed Mar 11 14:42:24 volumio kernel: usb 1-2: Not enough bandwidth for altsetting 1 Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:24 volumio kernel: 2:1:1: usb_set_interface failed (-22) Mar 11 14:42:24 volumio systemd-journal[2867]: Suppressed 546 messages from /system.slice/shairport-sync.service Mar 11 14:42:24 volumio shairport-sync[14759]: audio_alsa: Unable to set hw parameters for device "plughw:1,0": Input/output error. Mar 11 14:42:24 volumio shairport-sync[14759]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 % Total % Received % Xferd Average Speed Time Time Time Current Mar 11 14:42:24 volumio shairport-sync[14759]: Dload Upload Total Spent Left Speed Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Airplay started streaming, receiving metadatas Mar 11 14:42:24 volumio volumio[4976]: info: Mar 11 14:42:24 volumio volumio[4976]: ---------------------------- Client requests Start Airplay PlaybackRoutine Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Mar 11 14:42:24 volumio volumio[4976]: info: Airplay playback start Mar 11 14:42:24 volumio shairport-sync[14759]: [155B blob data] Mar 11 14:42:24 volumio volumio[4976]: info: Mar 11 14:42:24 volumio volumio[4976]: ---------------------------- Client requests AirplayActive Mar 11 14:42:24 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Mar 11 14:42:24 volumio shairport-sync[14759]: [143B blob data] Mar 11 14:42:24 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI xhci_drop_endpoint called with disabled ep ffffffc051d99880 Mar 11 14:42:24 volumio kernel: xhci-hcd xhci-hcd.0.auto: Trying to add endpoint 0x1 without dropping it. Mar 11 14:42:24 volumio kernel: usb 1-2: Not enough bandwidth for altsetting 1 Mar 11 14:42:24 volumio kernel: 2:1:1: usb_set_interface failed (-22) Mar 11 14:42:24 volumio shairport-sync[14759]: audio_alsa: Unable to set hw parameters for device "plughw:1,0": Input/output error. Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:25 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::servicePushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreStateMachine::pushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::volumioPushState Mar 11 14:42:26 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 14:42:26 volumio volumio[4976]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Awen/8261c13b-3c90-40b7-8a79-5df46bf00b74.jpg' Mar 11 14:42:27 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 11 14:42:27 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 11 14:42:27 volumio volumio[4976]: info: Discovery: Getting this device information Mar 11 14:42:27 volumio volumio[4976]: info: CoreCommandRouter::volumioGetState Mar 11 14:42:27 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Mar 11 14:42:27 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 11 14:42:27 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 11 14:42:30 volumio volumio[4976]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 11 14:42:31 volumio volumio[4976]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 11 14:42:31 volumio volumio[4976]: { Error: connect ETIMEDOUT 185.45.7.185:80 Mar 11 14:42:31 volumio volumio[4976]: at Object._errnoException (util.js:1022:11) Mar 11 14:42:31 volumio volumio[4976]: at _exceptionWithHostPort (util.js:1044:20) Mar 11 14:42:31 volumio volumio[4976]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 11 14:42:31 volumio volumio[4976]: code: 'ETIMEDOUT', Mar 11 14:42:31 volumio volumio[4976]: errno: 'ETIMEDOUT', Mar 11 14:42:31 volumio volumio[4976]: syscall: 'connect', Mar 11 14:42:31 volumio volumio[4976]: address: '185.45.7.185', Mar 11 14:42:31 volumio volumio[4976]: port: 80 } Mar 11 14:42:31 volumio volumio[4976]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 11 14:42:32 volumio sudo[14835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-11 14:41 Mar 11 14:42:32 volumio sudo[14835]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"