-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2025-03-05 23:50:01 CST. -- Mar 05 23:49:02 volumio volumio[4566]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 05 23:49:02 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 05 23:49:02 volumio volumio[4566]: info: Preparing to save Alsa Options, stopping services first Mar 05 23:49:02 volumio volumio[4566]: info: CoreCommandRouter::volumioGetState Mar 05 23:49:02 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:02 volumio volumio[4566]: info: CoreCommandRouter::volumioPause Mar 05 23:49:02 volumio volumio[4566]: info: CoreStateMachine::pause Mar 05 23:49:02 volumio volumio[4566]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"SMSL USB AUDIO"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Mar 05 23:49:02 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 05 23:49:03 volumio volumio[4566]: info: Setting mixer SMSL USB AUDIO for card SMSL USB AUDIO Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 05 23:49:03 volumio volumio[4566]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: SMSL USB AUDIO Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 05 23:49:03 volumio volumio[4566]: info: Disabling external Volume Control Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 23:49:03 volumio volumio[4566]: info: Preparing to generate the ALSA configuration file Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 05 23:49:03 volumio volumio[4566]: info: Asound.conf file unchanged, so no further update is needed Mar 05 23:49:03 volumio volumio[4566]: info: Output device has changed, restarting MPD Mar 05 23:49:03 volumio sudo[5254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 23:49:03 volumio sudo[5254]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:03 volumio volumio[4566]: info: Output device has changed, restarting Shairport Sync Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:03 volumio sudo[5254]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:03 volumio sudo[5256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 23:49:03 volumio sudo[5256]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:03 volumio systemd[1]: Stopping Music Player Daemon... Mar 05 23:49:03 volumio volumio[4566]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 05 23:49:03 volumio systemd[1]: mpd.service: Succeeded. Mar 05 23:49:03 volumio systemd[1]: Stopped Music Player Daemon. Mar 05 23:49:03 volumio volumio[4566]: info: MPD Permissions set Mar 05 23:49:03 volumio volumio[4566]: info: VolumeController:: Volume=100 Mute =false Mar 05 23:49:03 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:03 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:03 volumio volumio[4566]: info: Starting Shairport Sync Mar 05 23:49:03 volumio systemd[1]: Starting Music Player Daemon... Mar 05 23:49:03 volumio sudo[5296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 05 23:49:03 volumio sudo[5296]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:03 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 05 23:49:03 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 05 23:49:03 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 05 23:49:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 05 23:49:03 volumio sudo[5296]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:03 volumio volumio[4566]: info: Shairport-Sync Started Mar 05 23:49:03 volumio sudo[5272]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 05 23:49:03 volumio sudo[5272]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:03 volumio sudo[5272]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:04 volumio mpd[5311]: Mar 05 23:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 05 23:49:04 volumio systemd[1]: Started Music Player Daemon. Mar 05 23:49:04 volumio sudo[5256]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:04 volumio volumio[4566]: error: updateQueue error: null Mar 05 23:49:06 volumio volumio[4566]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Mar 05 23:49:06 volumio volumio[4566]: info: Retrying Login Due to Network Error Mar 05 23:49:07 volumio volumio[4566]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 05 23:49:07 volumio volumio[4566]: info: CoreStateMachine::getcurrentVolume Mar 05 23:49:07 volumio volumio[4566]: info: CoreCommandRouter::volumioRetrievevolume Mar 05 23:49:07 volumio volumio[4566]: info: VolumeController:: Volume=100 Mute =false Mar 05 23:49:07 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:07 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:07 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:07 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:07 volumio volumio[4566]: info: CoreStateMachine::updateTrackBlock Mar 05 23:49:07 volumio volumio[4566]: info: CorePlayQueue::getTrackBlock Mar 05 23:49:07 volumio volumio[4566]: info: CoreCommandRouter::volumioRetrievevolume Mar 05 23:49:07 volumio volumio[4566]: info: VolumeController:: Volume=100 Mute =false Mar 05 23:49:07 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:07 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:07 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:08 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:09 volumio volumio[4566]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Mar 05 23:49:09 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Mar 05 23:49:09 volumio volumio[4566]: info: CoreCommandRouter::volumioGetState Mar 05 23:49:09 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:09 volumio volumio[4566]: info: Restoring Previous Volume level: 100 false false Mar 05 23:49:09 volumio volumio[4566]: info: Volume configurations have been set Mar 05 23:49:09 volumio volumio[4566]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 05 23:49:09 volumio volumio[4566]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: SMSL USB AUDIO ,1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 05 23:49:09 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 05 23:49:09 volumio volumio[4566]: info: Disabling external Volume Control Mar 05 23:49:09 volumio volumio[4566]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 23:49:09 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 05 23:49:09 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:09 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 05 23:49:10 volumio volumio[4566]: info: VolumeController:: Volume=100 Mute =false Mar 05 23:49:10 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:10 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:10 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:11 volumio volumio[4566]: info: CoreCommandRouter::volumioPlay Mar 05 23:49:11 volumio volumio[4566]: info: CoreStateMachine::play index undefined Mar 05 23:49:11 volumio volumio[4566]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 23:49:11 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:11 volumio volumio[4566]: info: CoreStateMachine::startPlaybackTimer Mar 05 23:49:11 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:11 volumio volumio[4566]: info: ControllerMpd::resume Mar 05 23:49:11 volumio volumio[4566]: verbose: ControllerMpd::sendMpdCommand play Mar 05 23:49:11 volumio volumio[4566]: info: sendMpdCommand play took 2 milliseconds Mar 05 23:49:14 volumio volumio[4566]: info: VolumeController::SetAlsaVolume100 Mar 05 23:49:14 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:14 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:14 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:14 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:16 volumio volumio[4566]: info: MyVolumio login type: Token Mar 05 23:49:23 volumio volumio[4566]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::volumioGetState Mar 05 23:49:23 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:23 volumio volumio[4566]: info: Restoring Previous Volume level: 100 false false Mar 05 23:49:23 volumio volumio[4566]: info: Volume configurations have been set Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 05 23:49:23 volumio volumio[4566]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: SMSL USB AUDIO ,1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 05 23:49:23 volumio volumio[4566]: info: Disabling external Volume Control Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 05 23:49:23 volumio volumio[4566]: info: VolumeController:: Volume=100 Mute =false Mar 05 23:49:23 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:23 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:23 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:25 volumio volumio[4566]: info: CoreCommandRouter::volumioPlay Mar 05 23:49:25 volumio volumio[4566]: info: CoreStateMachine::play index undefined Mar 05 23:49:25 volumio volumio[4566]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 23:49:25 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:25 volumio volumio[4566]: info: CoreStateMachine::startPlaybackTimer Mar 05 23:49:25 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:25 volumio volumio[4566]: info: ControllerMpd::resume Mar 05 23:49:25 volumio volumio[4566]: verbose: ControllerMpd::sendMpdCommand play Mar 05 23:49:25 volumio volumio[4566]: info: sendMpdCommand play took 1 milliseconds Mar 05 23:49:27 volumio volumio[4566]: info: VolumeController::SetAlsaVolume100 Mar 05 23:49:27 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:27 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:27 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:27 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:36 volumio volumio[4566]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Mar 05 23:49:36 volumio sudo[5393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 23:49:36 volumio sudo[5393]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:36 volumio sudo[5393]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:36 volumio sudo[5395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 23:49:36 volumio sudo[5395]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:36 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:36 volumio volumio[4566]: info: MPD Permissions set Mar 05 23:49:36 volumio systemd[1]: Stopping Music Player Daemon... Mar 05 23:49:36 volumio systemd[1]: mpd.service: Succeeded. Mar 05 23:49:36 volumio systemd[1]: Stopped Music Player Daemon. Mar 05 23:49:36 volumio systemd[1]: Starting Music Player Daemon... Mar 05 23:49:36 volumio sudo[5402]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 05 23:49:36 volumio sudo[5402]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:36 volumio sudo[5402]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:37 volumio mpd[5404]: Mar 05 23:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 05 23:49:37 volumio systemd[1]: Started Music Player Daemon. Mar 05 23:49:37 volumio sudo[5395]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:37 volumio volumio[4566]: error: updateQueue error: null Mar 05 23:49:44 volumio volumio[4566]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::volumioGetState Mar 05 23:49:44 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Mar 05 23:49:44 volumio sudo[5423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 23:49:44 volumio volumio[4566]: info: Restoring Previous Volume level: 100 false false Mar 05 23:49:44 volumio sudo[5423]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:44 volumio volumio[4566]: info: Volume configurations have been set Mar 05 23:49:44 volumio sudo[5423]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:44 volumio sudo[5425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 23:49:44 volumio sudo[5425]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:44 volumio systemd[1]: Stopping Music Player Daemon... Mar 05 23:49:44 volumio systemd[1]: mpd.service: Succeeded. Mar 05 23:49:44 volumio systemd[1]: Stopped Music Player Daemon. Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 05 23:49:44 volumio volumio[4566]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: SMSL USB AUDIO ,1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 05 23:49:44 volumio volumio[4566]: info: Disabling external Volume Control Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 23:49:44 volumio volumio[4566]: info: MPD Permissions set Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio systemd[1]: Starting Music Player Daemon... Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 05 23:49:44 volumio sudo[5430]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 05 23:49:44 volumio sudo[5430]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:44 volumio sudo[5430]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 05 23:49:44 volumio volumio[4566]: info: VolumeController:: Volume=100 Mute =false Mar 05 23:49:44 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:44 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:44 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:44 volumio mpd[5441]: Mar 05 23:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 05 23:49:44 volumio systemd[1]: Started Music Player Daemon. Mar 05 23:49:44 volumio sudo[5425]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:44 volumio volumio[4566]: error: updateQueue error: null Mar 05 23:49:46 volumio volumio[4566]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Mar 05 23:49:46 volumio volumio[4566]: info: Retrying Login Due to Network Error Mar 05 23:49:46 volumio volumio[4566]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::volumioGetState Mar 05 23:49:46 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Mar 05 23:49:46 volumio sudo[5449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 23:49:46 volumio sudo[5449]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:46 volumio volumio[4566]: info: Restoring Previous Volume level: 100 false false Mar 05 23:49:46 volumio volumio[4566]: info: Volume configurations have been set Mar 05 23:49:46 volumio sudo[5449]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:46 volumio sudo[5452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 23:49:46 volumio sudo[5452]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:46 volumio systemd[1]: Stopping Music Player Daemon... Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 05 23:49:46 volumio volumio[4566]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: SMSL USB AUDIO ,1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 05 23:49:46 volumio volumio[4566]: info: Disabling external Volume Control Mar 05 23:49:46 volumio systemd[1]: mpd.service: Succeeded. Mar 05 23:49:46 volumio systemd[1]: Stopped Music Player Daemon. Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 23:49:46 volumio volumio[4566]: info: MPD Permissions set Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 23:49:46 volumio systemd[1]: Starting Music Player Daemon... Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 05 23:49:46 volumio sudo[5457]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 05 23:49:46 volumio sudo[5457]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 23:49:46 volumio sudo[5457]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 05 23:49:46 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 05 23:49:47 volumio volumio[4566]: info: VolumeController:: Volume=100 Mute =false Mar 05 23:49:47 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:47 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:47 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:47 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:47 volumio mpd[5467]: Mar 05 23:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 05 23:49:47 volumio systemd[1]: Started Music Player Daemon. Mar 05 23:49:47 volumio sudo[5452]: pam_unix(sudo:session): session closed for user root Mar 05 23:49:47 volumio volumio[4566]: error: updateQueue error: null Mar 05 23:49:48 volumio volumio[4566]: info: VolumeController::SetAlsaVolume100 Mar 05 23:49:48 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:48 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:48 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:48 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:51 volumio volumio[4566]: info: VolumeController::SetAlsaVolume100 Mar 05 23:49:51 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:51 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:51 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:51 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:56 volumio volumio[4566]: info: MyVolumio login type: Token Mar 05 23:49:56 volumio volumio[4566]: info: CoreCommandRouter::volumioGetState Mar 05 23:49:56 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:57 volumio volumio[4566]: info: CoreCommandRouter::volumioPlay Mar 05 23:49:57 volumio volumio[4566]: info: CoreStateMachine::play index undefined Mar 05 23:49:57 volumio volumio[4566]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 23:49:57 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:57 volumio volumio[4566]: info: CoreStateMachine::startPlaybackTimer Mar 05 23:49:57 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:57 volumio volumio[4566]: info: ControllerMpd::resume Mar 05 23:49:57 volumio volumio[4566]: verbose: ControllerMpd::sendMpdCommand play Mar 05 23:49:57 volumio volumio[4566]: info: sendMpdCommand play took 1 milliseconds Mar 05 23:49:59 volumio volumio[4566]: info: CoreCommandRouter::volumioSeek Mar 05 23:49:59 volumio volumio[4566]: info: CoreStateMachine::seek Mar 05 23:49:59 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:59 volumio volumio[4566]: info: TRACKBLOCK {"uri":"mnt/NAS/nas/G.E.M.邓紫棋/G.E.M.邓紫棋 - 18/6. 塞納河.flac","service":"mpd","name":"塞納河","artist":"G.E.M.","album":"18…","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=54&web=G.E.M./18%E2%80%A6/extralarge&path=%2FNAS%2Fnas%2FG.E.M.%E9%82%93%E7%B4%AB%E6%A3%8B%2FG.E.M.%E9%82%93%E7%B4%AB%E6%A3%8B%20-%2018&metadata=false","duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Mar 05 23:49:59 volumio volumio[4566]: info: CoreStateMachine::startPlaybackTimer Mar 05 23:49:59 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:59 volumio volumio[4566]: info: ControllerMpd::seek Mar 05 23:49:59 volumio volumio[4566]: info: CoreStateMachine::pushState Mar 05 23:49:59 volumio volumio[4566]: info: CorePlayQueue::getTrack 5 Mar 05 23:49:59 volumio volumio[4566]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 23:49:59 volumio volumio[4566]: info: CoreCommandRouter::volumioPushState Mar 05 23:49:59 volumio volumio[4566]: error: [2@0] {seek} Bad song index Mar 05 23:50:01 volumio volumio[4566]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 23:50:01 volumio volumio[4566]: Error: connect ETIMEDOUT 182.50.139.56:80 Mar 05 23:50:01 volumio volumio[4566]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 05 23:50:01 volumio volumio[4566]: errno: -110, Mar 05 23:50:01 volumio volumio[4566]: code: 'ETIMEDOUT', Mar 05 23:50:01 volumio volumio[4566]: syscall: 'connect', Mar 05 23:50:01 volumio volumio[4566]: address: '182.50.139.56', Mar 05 23:50:01 volumio volumio[4566]: port: 80 Mar 05 23:50:01 volumio volumio[4566]: } Mar 05 23:50:01 volumio volumio[4566]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 23:50:01 volumio sudo[5514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-05 23:49 Mar 05 23:50:01 volumio sudo[5514]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"