-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Fri 2024-04-19 14:07:39 CST. -- Apr 19 14:06:02 volumio volumio[699]: info: VolumeController::SetAlsaVolume0 Apr 19 14:06:02 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:02 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:02 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:02 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:02 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:03 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:03 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:03 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:03 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:03 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:03 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:03 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:03 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:03 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:03 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:03 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:03 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:03 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:03 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:03 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:03 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:03 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:03 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:03 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:03 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:03 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:03 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:03 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:03 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:04 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:04 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:04 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:04 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:04 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:04 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:04 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:07 volumio volumio[699]: info: Apr 19 14:06:07 volumio volumio[699]: ---------------------------- Client requests Volume + Apr 19 14:06:07 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:07 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:07 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:07 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:07 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:07 volumio volumio[699]: info: Apr 19 14:06:07 volumio volumio[699]: ---------------------------- Client requests Volume + Apr 19 14:06:07 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:07 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:07 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:07 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:07 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:08 volumio volumio[699]: info: Apr 19 14:06:08 volumio volumio[699]: ---------------------------- Client requests Volume + Apr 19 14:06:08 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:08 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:08 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:08 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:08 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:08 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:08 volumio volumio[699]: info: Apr 19 14:06:08 volumio volumio[699]: ---------------------------- Client requests Volume + Apr 19 14:06:08 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:08 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:08 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:08 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:08 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:08 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:08 volumio volumio[699]: info: Apr 19 14:06:08 volumio volumio[699]: ---------------------------- Client requests Volume + Apr 19 14:06:08 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:08 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:08 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:08 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:08 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:08 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:12 volumio volumio[699]: info: VolumeController::SetAlsaVolume40 Apr 19 14:06:12 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:12 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:12 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:12 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:12 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:12 volumio volumio[699]: info: VolumeController::SetAlsaVolume0 Apr 19 14:06:12 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:12 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:12 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:12 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:12 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:13 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:13 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:13 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:13 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:13 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:13 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:14 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:14 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:14 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:14 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:14 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:14 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:14 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:14 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:14 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:14 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:14 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:14 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:14 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:14 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:14 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:14 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:14 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:14 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:14 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:14 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:15 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:15 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:15 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:15 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:15 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:15 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:15 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:15 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:15 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:15 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:15 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:15 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:18 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:18 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:18 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:18 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:18 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:18 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:19 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:19 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:19 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:19 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:19 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:19 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:19 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:19 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:19 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:19 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:19 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:19 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:20 volumio volumio[699]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 19 14:06:20 volumio volumio[699]: info: Retrying Login Due to Network Error Apr 19 14:06:21 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:21 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:21 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:21 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:21 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:21 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:21 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:21 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:21 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:21 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:21 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:21 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 19 14:06:27 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 19 14:06:30 volumio volumio[699]: info: MyVolumio login type: Token Apr 19 14:06:34 volumio volumio[699]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::volumioGetState Apr 19 14:06:34 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:34 volumio volumio[699]: info: Restoring Previous Volume level: 60 false true Apr 19 14:06:34 volumio volumio[699]: info: VolumeController::SetAlsaVolume100 Apr 19 14:06:34 volumio volumio[699]: info: Enable softmixer device for audio device number 5 Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::volumioStop Apr 19 14:06:34 volumio volumio[699]: info: CoreStateMachine::stop Apr 19 14:06:34 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:06:34 volumio volumio[699]: info: CoreStateMachine::stPlaybackTimer Apr 19 14:06:34 volumio volumio[699]: info: CoreStateMachine::updateTrackBlock Apr 19 14:06:34 volumio volumio[699]: info: CorePlayQueue::getTrackBlock Apr 19 14:06:34 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:34 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:34 volumio volumio[699]: info: CoreStateMachine::serviceStop Apr 19 14:06:34 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::serviceStop Apr 19 14:06:34 volumio volumio[699]: info: ControllerMpd::stop Apr 19 14:06:34 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 14:06:34 volumio volumio[699]: info: Enable softmixer device for audio device undefined Apr 19 14:06:34 volumio volumio[699]: info: Output device has changed, restarting MPD Apr 19 14:06:34 volumio sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 14:06:34 volumio sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:34 volumio volumio[699]: info: Output device has changed, restarting Shairport Sync Apr 19 14:06:34 volumio sudo[1397]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:06:34 volumio sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 14:06:34 volumio sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:34 volumio systemd[1]: Stopping Music Player Daemon... Apr 19 14:06:34 volumio volumio[699]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 19 14:06:34 volumio volumio[699]: info: Volume configurations have been set Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 19 14:06:34 volumio volumio[699]: info: Updating Volume Controller Parameters: Device: 5 Name: HD-AUDIO USB-INTERFACE Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 19 14:06:34 volumio volumio[699]: info: Disabling external Volume Control Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 14:06:34 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:34 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:34 volumio volumio[699]: error: MPD error: Error: write EPIPE Apr 19 14:06:34 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:34 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:34 volumio systemd[1]: mpd.service: Succeeded. Apr 19 14:06:34 volumio systemd[1]: Stopped Music Player Daemon. Apr 19 14:06:34 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:34 volumio volumio[699]: info: MPD Permissions set Apr 19 14:06:34 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:34 volumio systemd[1]: Starting Music Player Daemon... Apr 19 14:06:34 volumio volumio[699]: info: Software Volume ALSA configuration written Apr 19 14:06:34 volumio volumio[699]: info: Preparing to generate the ALSA configuration file Apr 19 14:06:34 volumio volumio[699]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 19 14:06:34 volumio volumio[699]: info: Reading ALSA contributions from plugins. Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 19 14:06:34 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 19 14:06:34 volumio volumio[699]: info: Starting Shairport Sync Apr 19 14:06:34 volumio volumio[699]: info: Asound.conf file written Apr 19 14:06:34 volumio sudo[1426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 19 14:06:34 volumio sudo[1426]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 19 14:06:34 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 19 14:06:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 19 14:06:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 19 14:06:34 volumio sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 19 14:06:34 volumio sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:34 volumio sudo[1426]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:36 volumio sudo[1429]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:36 volumio mpd[1424]: Apr 19 14:06 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 19 14:06:36 volumio volumio[699]: info: Output device has changed, restarting MPD Apr 19 14:06:36 volumio sudo[1437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 14:06:36 volumio sudo[1437]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:36 volumio volumio[699]: info: Output device has changed, restarting Shairport Sync Apr 19 14:06:36 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:36 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:06:36 volumio sudo[1437]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:36 volumio sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 14:06:36 volumio sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:36 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 19 14:06:36 volumio systemd[1]: mpd.service: Succeeded. Apr 19 14:06:36 volumio systemd[1]: Stopped Music Player Daemon. Apr 19 14:06:36 volumio volumio[699]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 19 14:06:36 volumio systemd[1]: Starting Music Player Daemon... Apr 19 14:06:37 volumio mpd[1449]: Apr 19 14:06 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 19 14:06:37 volumio mpd[1449]: Apr 19 14:06 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 19 14:06:37 volumio mpd[1449]: Apr 19 14:06 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 19 14:06:37 volumio systemd[1]: Started Music Player Daemon. Apr 19 14:06:37 volumio sudo[1400]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:37 volumio sudo[1439]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:37 volumio volumio[699]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 19 14:06:37 volumio volumio[699]: info: Output device has changed, restarting MPD Apr 19 14:06:37 volumio sudo[1455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 14:06:37 volumio sudo[1455]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:38 volumio volumio[699]: info: Output device has changed, restarting Shairport Sync Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:06:38 volumio sudo[1455]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:38 volumio sudo[1458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 14:06:38 volumio sudo[1458]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:38 volumio systemd[1]: Stopping Music Player Daemon... Apr 19 14:06:38 volumio volumio[699]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 19 14:06:38 volumio systemd[1]: mpd.service: Succeeded. Apr 19 14:06:38 volumio systemd[1]: Stopped Music Player Daemon. Apr 19 14:06:38 volumio systemd[1]: Starting Music Player Daemon... Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 19 14:06:38 volumio volumio[699]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 19 14:06:38 volumio volumio[699]: info: Disabling external Volume Control Apr 19 14:06:38 volumio volumio[699]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 19 14:06:38 volumio volumio[699]: info: MPD Permissions set Apr 19 14:06:38 volumio volumio[699]: info: MPD Permissions set Apr 19 14:06:38 volumio volumio[699]: info: Shairport-Sync Started Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:06:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:38 volumio volumio[699]: info: Starting Shairport Sync Apr 19 14:06:38 volumio volumio[699]: info: Starting Shairport Sync Apr 19 14:06:38 volumio sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 19 14:06:38 volumio sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:38 volumio sudo[1486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 19 14:06:38 volumio sudo[1486]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 19 14:06:38 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 19 14:06:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 19 14:06:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 19 14:06:38 volumio sudo[1484]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:38 volumio volumio[699]: info: Shairport-Sync Started Apr 19 14:06:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 19 14:06:38 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 19 14:06:38 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 19 14:06:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 19 14:06:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 19 14:06:38 volumio sudo[1486]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:38 volumio volumio[699]: info: Shairport-Sync Started Apr 19 14:06:38 volumio mpd[1478]: Apr 19 14:06 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 19 14:06:38 volumio mpd[1478]: Apr 19 14:06 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 19 14:06:38 volumio mpd[1478]: Apr 19 14:06 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 19 14:06:38 volumio systemd[1]: Started Music Player Daemon. Apr 19 14:06:38 volumio sudo[1458]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:38 volumio volumio[699]: error: MPD error: The expression evaluated to a falsy value: Apr 19 14:06:38 volumio volumio[699]: assert.ok(self.idling) Apr 19 14:06:38 volumio volumio[699]: Upnp client error: Error: This socket has been ended by the other party Apr 19 14:06:38 volumio volumio[699]: error: updateQueue error: null Apr 19 14:06:38 volumio volumio[699]: error: updateQueue error: null Apr 19 14:06:39 volumio volumio[699]: info: VolumeController::SetAlsaVolume60 Apr 19 14:06:39 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:39 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:06:39 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:39 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:39 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 19 14:06:39 volumio sudo[1497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 14:06:39 volumio sudo[1497]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:06:39 volumio systemd[1]: Stopping Music Player Daemon... Apr 19 14:06:39 volumio systemd[1]: mpd.service: Succeeded. Apr 19 14:06:39 volumio systemd[1]: Stopped Music Player Daemon. Apr 19 14:06:39 volumio systemd[1]: Starting Music Player Daemon... Apr 19 14:06:40 volumio mpd[1501]: Apr 19 14:06 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 19 14:06:40 volumio mpd[1501]: Apr 19 14:06 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 19 14:06:40 volumio mpd[1501]: Apr 19 14:06 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 19 14:06:40 volumio systemd[1]: Started Music Player Daemon. Apr 19 14:06:40 volumio volumio[699]: error: updateQueue error: null Apr 19 14:06:40 volumio sudo[1497]: pam_unix(sudo:session): session closed for user root Apr 19 14:06:40 volumio volumio[699]: error: updateQueue error: null Apr 19 14:06:43 volumio volumio[699]: error: updateQueue error: null Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::volumioNext Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::next Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::stop Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::play index undefined Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::startPlaybackTimer Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::clearAddPlayTracks USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::updateTrackBlock Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrackBlock Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand stop took 2 milliseconds Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand clear Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:06:45 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand clear took 2 milliseconds Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand add "USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf" Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:06:45 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:06:45 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:06:45 volumio volumio[699]: error: updateQueue error: null Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:06:45 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:06:45 volumio volumio[699]: info: ------------------------------ 10ms Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand add "USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf" took 8 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: ------------------------------ 8ms Apr 19 14:06:45 volumio volumio[699]: info: ------------------------------ 8ms Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand play Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:06:45 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:06:45 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:06:45 volumio volumio[699]: info: ------------------------------ 6ms Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand play took 3 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: ------------------------------ 2ms Apr 19 14:06:45 volumio volumio[699]: info: ------------------------------ 1ms Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand status took 27 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand status took 28 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand status took 26 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand status took 1 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"重复","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf","trackType":"dsf"} Apr 19 14:06:45 volumio volumio[699]: verbose: CURRENT POSITION 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus stop Apr 19 14:06:45 volumio volumio[699]: info: ------------------------------ 33ms Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:06:45 volumio volumio[699]: info: Apr 19 14:06:45 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand status took 2 milliseconds Apr 19 14:06:45 volumio volumio[699]: info: sendMpdCommand status took 1 milliseconds Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:06:45 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"重复","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf","trackType":"dsf"} Apr 19 14:06:45 volumio volumio[699]: verbose: CURRENT POSITION 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:06:45 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"重复","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf","trackType":"dsf"} Apr 19 14:06:45 volumio volumio[699]: verbose: CURRENT POSITION 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:06:45 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:45 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":245,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"重复","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf","trackType":"dsf"} Apr 19 14:06:45 volumio volumio[699]: verbose: CURRENT POSITION 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:06:45 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:45 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:45 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:45 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:46 volumio volumio[699]: info: ------------------------------ 148ms Apr 19 14:06:46 volumio volumio[699]: info: ------------------------------ 147ms Apr 19 14:06:46 volumio volumio[699]: info: ------------------------------ 122ms Apr 19 14:06:46 volumio volumio[699]: info: sendMpdCommand playlistinfo took 114 milliseconds Apr 19 14:06:46 volumio volumio[699]: info: sendMpdCommand playlistinfo took 111 milliseconds Apr 19 14:06:46 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:06:46 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:06:46 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:06:46 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:06:46 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:46 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114,"duration":245,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"重复","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf","trackType":"dsf"} Apr 19 14:06:46 volumio volumio[699]: verbose: CURRENT POSITION 8 Apr 19 14:06:46 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:06:46 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:06:46 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:06:46 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:46 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:46 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:46 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:46 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:46 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:46 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:46 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:06:46 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:06:46 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:46 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":137,"duration":245,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"重复","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf","trackType":"dsf"} Apr 19 14:06:46 volumio volumio[699]: verbose: CURRENT POSITION 8 Apr 19 14:06:46 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:06:46 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:06:46 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:06:46 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:46 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:46 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:46 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:46 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:46 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:46 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:46 volumio volumio[699]: info: ------------------------------ 140ms Apr 19 14:06:46 volumio volumio[699]: info: ------------------------------ 140ms Apr 19 14:06:49 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:49 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:49 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:49 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:49 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:49 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:49 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:49 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:49 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:49 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:49 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:49 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:49 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:49 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:49 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:49 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:50 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:50 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:50 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:50 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:50 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:50 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:50 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:50 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:50 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:50 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:50 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:50 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:50 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:50 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:06:56 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:06:56 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:06:56 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:06:56 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:06:56 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:00 volumio volumio[699]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 19 14:07:00 volumio volumio[699]: info: Retrying Login Due to Network Error Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPlay Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::play index 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::stop Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::stPlaybackTimer Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::updateTrackBlock Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrackBlock Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::serviceStop Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 8 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::serviceStop Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::stop Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand stop took 110 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::play index undefined Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::startPlaybackTimer Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::clearAddPlayTracks USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 7 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand stop took 5 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 4 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 2 milliseconds Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand clear Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:04 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand clear took 4 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand add "USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf" Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"重复","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/09.重复.dsf","trackType":"dsf"} Apr 19 14:07:04 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState stateService stop Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus stop Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: No code Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 19 14:07:04 volumio volumio[699]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 41ms Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 36ms Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 34ms Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:04 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:04 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:04 volumio volumio[699]: error: updateQueue error: null Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:04 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 33ms Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand add "USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf" took 30 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 5ms Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 5ms Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand play Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:04 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:04 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 14ms Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand play took 12 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 12ms Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 11ms Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 14 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 12 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 12 milliseconds Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: Apr 19 14:07:04 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 9 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 5 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand status took 3 milliseconds Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:04 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus stop Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:04 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:04 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:04 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:04 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 52ms Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 62ms Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 61ms Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 38 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 37 milliseconds Apr 19 14:07:04 volumio volumio[699]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":74,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:04 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:04 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":171,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:04 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:04 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:04 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:04 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:04 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:04 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 120ms Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 114ms Apr 19 14:07:04 volumio volumio[699]: info: ------------------------------ 112ms Apr 19 14:07:05 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:07:05 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:05 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:05 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:05 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:06 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:07:06 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:06 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:06 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:06 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:07:06 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:06 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:06 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:06 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:06 volumio volumio[699]: info: VolumeController::SetAlsaVolume+ Apr 19 14:07:06 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:06 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:06 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:06 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 19 14:07:07 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 19 14:07:10 volumio volumio[699]: info: MyVolumio login type: Token Apr 19 14:07:13 volumio volumio[699]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Apr 19 14:07:13 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Apr 19 14:07:13 volumio volumio[699]: info: CoreCommandRouter::volumioGetState Apr 19 14:07:13 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:13 volumio volumio[699]: info: Disable softmixer device for audio device Apr 19 14:07:13 volumio volumio[699]: info: Output device has changed, restarting MPD Apr 19 14:07:13 volumio sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 14:07:13 volumio sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:07:13 volumio volumio[699]: info: Output device has changed, restarting Shairport Sync Apr 19 14:07:13 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:13 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:07:13 volumio sudo[1593]: pam_unix(sudo:session): session closed for user root Apr 19 14:07:13 volumio sudo[1596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 14:07:13 volumio sudo[1596]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:07:13 volumio systemd[1]: Stopping Music Player Daemon... Apr 19 14:07:13 volumio volumio[699]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 19 14:07:13 volumio volumio[699]: info: Restoring Previous Volume level: 100 false false Apr 19 14:07:13 volumio volumio[699]: info: Volume configurations have been set Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 19 14:07:14 volumio volumio[699]: info: Updating Volume Controller Parameters: Device: 5 Name: HD-AUDIO USB-INTERFACE Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 19 14:07:14 volumio volumio[699]: info: Disabling external Volume Control Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 14:07:14 volumio volumio[699]: info: Soft Volume ALSA configuration file deleted Apr 19 14:07:14 volumio volumio[699]: info: Preparing to generate the ALSA configuration file Apr 19 14:07:14 volumio volumio[699]: info: MPD Permissions set Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio systemd[1]: mpd.service: Succeeded. Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:07:14 volumio systemd[1]: Stopped Music Player Daemon. Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio systemd[1]: Starting Music Player Daemon... Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 19 14:07:14 volumio volumio[699]: error: Upnp client error: Error: read ECONNRESET Apr 19 14:07:14 volumio volumio[699]: info: VolumeController:: Volume=38 Mute =false Apr 19 14:07:14 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:14 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:14 volumio volumio[699]: info: Starting Shairport Sync Apr 19 14:07:14 volumio volumio[699]: info: Asound.conf file written Apr 19 14:07:14 volumio sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 19 14:07:14 volumio sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:07:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 19 14:07:14 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 19 14:07:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 19 14:07:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 19 14:07:14 volumio sudo[1617]: pam_unix(sudo:session): session closed for user root Apr 19 14:07:14 volumio sudo[1620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 19 14:07:14 volumio sudo[1620]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:07:14 volumio sudo[1620]: pam_unix(sudo:session): session closed for user root Apr 19 14:07:14 volumio volumio[699]: info: Output device has changed, restarting MPD Apr 19 14:07:14 volumio sudo[1628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 14:07:14 volumio sudo[1628]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:07:14 volumio volumio[699]: info: Output device has changed, restarting Shairport Sync Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:07:14 volumio sudo[1628]: pam_unix(sudo:session): session closed for user root Apr 19 14:07:14 volumio sudo[1631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 14:07:14 volumio sudo[1631]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:07:14 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 19 14:07:14 volumio systemd[1]: mpd.service: Succeeded. Apr 19 14:07:14 volumio systemd[1]: Stopped Music Player Daemon. Apr 19 14:07:14 volumio systemd[1]: Starting Music Player Daemon... Apr 19 14:07:14 volumio volumio[699]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 19 14:07:14 volumio volumio[699]: info: MPD Permissions set Apr 19 14:07:14 volumio volumio[699]: info: Shairport-Sync Started Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 14:07:14 volumio volumio[699]: info: Starting Shairport Sync Apr 19 14:07:14 volumio sudo[1643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 19 14:07:14 volumio sudo[1643]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 14:07:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 19 14:07:14 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 19 14:07:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 19 14:07:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 19 14:07:14 volumio sudo[1643]: pam_unix(sudo:session): session closed for user root Apr 19 14:07:14 volumio volumio[699]: info: Shairport-Sync Started Apr 19 14:07:15 volumio mpd[1646]: Apr 19 14:07 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 19 14:07:15 volumio mpd[1646]: Apr 19 14:07 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 19 14:07:15 volumio mpd[1646]: Apr 19 14:07 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 19 14:07:15 volumio systemd[1]: Started Music Player Daemon. Apr 19 14:07:15 volumio sudo[1631]: pam_unix(sudo:session): session closed for user root Apr 19 14:07:15 volumio sudo[1596]: pam_unix(sudo:session): session closed for user root Apr 19 14:07:15 volumio volumio[699]: error: MPD error: The expression evaluated to a falsy value: Apr 19 14:07:15 volumio volumio[699]: assert.ok(self.idling) Apr 19 14:07:15 volumio volumio[699]: error: updateQueue error: null Apr 19 14:07:18 volumio volumio[699]: info: VolumeController::SetAlsaVolume100 Apr 19 14:07:18 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:18 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:18 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:18 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: error: updateQueue error: null Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioNext Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::next Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::stop Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::stPlaybackTimer Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::updateTrackBlock Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrackBlock Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::serviceStop Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::serviceStop Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::stop Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand stop took 6 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::play index undefined Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::startPlaybackTimer Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::clearAddPlayTracks USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::updateTrackBlock Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrackBlock Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand stop took 1 milliseconds Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand clear Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:20 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand clear took 1 milliseconds Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand add "USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf" Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:20 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:20 volumio volumio[699]: error: updateQueue error: null Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:20 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 2ms Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand add "USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf" took 2 milliseconds Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand play Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:20 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:20 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 4ms Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 3ms Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand play took 3 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 3ms Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 2ms Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:20 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 1ms Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand status took 8 milliseconds Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand status took 9 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand status took 8 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:20 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus stop Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 15ms Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:20 volumio volumio[699]: info: Apr 19 14:07:20 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand status took 7 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand status took 17 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand status took 16 milliseconds Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:20 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:20 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:20 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:20 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 57ms Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 56ms Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 19 14:07:20 volumio volumio[699]: info: sendMpdCommand playlistinfo took 25 milliseconds Apr 19 14:07:20 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:20 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:20 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:20 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:20 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:20 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:20 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:20 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:20 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 74ms Apr 19 14:07:20 volumio volumio[699]: info: ------------------------------ 70ms Apr 19 14:07:23 volumio volumio[699]: info: VolumeController::SetAlsaVolume- Apr 19 14:07:23 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:23 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:23 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:23 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:23 volumio volumio[699]: info: VolumeController::SetAlsaVolume- Apr 19 14:07:23 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:23 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:23 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:23 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:24 volumio volumio[699]: info: VolumeController::SetAlsaVolume- Apr 19 14:07:25 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:25 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:25 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:25 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::volumioSeek Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::seek Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: TRACKBLOCK {"uri":"mnt/USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","service":"mpd","name":"2 - 婚纱背后","artist":"徐小凤","album":"极品之选","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=369&web=%E5%BE%90%E5%B0%8F%E5%87%A4/%E6%9E%81%E5%93%81%E4%B9%8B%E9%80%89/large&path=%2FUSB%2Fmusic%2FMusic%2F%E3%80%90SACD%E3%80%81DSD%E3%80%81ISO%E3%80%91%2F%E6%B8%AF%E5%8F%B0%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E6%9E%81%E5%93%81%E4%B9%8B%E9%80%89&metadata=false","duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","trackType":"dsf","channels":2} Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::startPlaybackTimer Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: ControllerMpd::seek Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:28 volumio volumio[699]: error: null Apr 19 14:07:28 volumio volumio[699]: info: Apr 19 14:07:28 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:28 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:28 volumio volumio[699]: info: Apr 19 14:07:28 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:28 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:28 volumio volumio[699]: info: Apr 19 14:07:28 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:28 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:28 volumio volumio[699]: info: sendMpdCommand status took 6 milliseconds Apr 19 14:07:28 volumio volumio[699]: info: sendMpdCommand status took 4 milliseconds Apr 19 14:07:28 volumio volumio[699]: info: sendMpdCommand status took 2 milliseconds Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:28 volumio volumio[699]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 19 14:07:28 volumio volumio[699]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 14:07:28 volumio volumio[699]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:28 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:28 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41000,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:28 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:28 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:28 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41000,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:28 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:28 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:28 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41000,"duration":290,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:28 volumio volumio[699]: verbose: CURRENT POSITION 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:28 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:28 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:28 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:28 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:28 volumio volumio[699]: info: ------------------------------ 60ms Apr 19 14:07:28 volumio volumio[699]: info: ------------------------------ 58ms Apr 19 14:07:28 volumio volumio[699]: info: ------------------------------ 56ms Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPlay Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::play index 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::stop Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::stPlaybackTimer Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::updateTrackBlock Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrackBlock Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::serviceStop Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 1 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::serviceStop Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::stop Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand stop took 146 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::play index undefined Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::startPlaybackTimer Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::clearAddPlayTracks USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand stop Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 4 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand stop took 3 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 2 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 2 milliseconds Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand clear Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:38 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand clear took 2 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand add "USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf" Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"婚纱背后","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/02.婚纱背后.dsf","trackType":"dsf"} Apr 19 14:07:38 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState stateService stop Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus stop Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: No code Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 19 14:07:38 volumio volumio[699]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 27ms Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 24ms Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 23ms Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:38 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:38 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:38 volumio volumio[699]: error: updateQueue error: null Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:38 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 22ms Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand add "USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf" took 22 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 3ms Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 2ms Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand play Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:38 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces system playlist update Apr 19 14:07:38 volumio volumio[699]: info: Ignoring MPD Status Update Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 17ms Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand play took 16 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 16ms Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 7ms Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 4 milliseconds Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 4 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 5 milliseconds Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: Apr 19 14:07:38 volumio volumio[699]: ---------------------------- MPD announces state update: player Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::getState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand status Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 4 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 3 milliseconds Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:38 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus stop Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:38 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:38 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:38 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:38 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 22ms Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 75ms Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 74ms Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand status took 68 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 66 milliseconds Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 66 milliseconds Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseState Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:38 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:38 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:38 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:38 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 105ms Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 103ms Apr 19 14:07:38 volumio volumio[699]: info: sendMpdCommand playlistinfo took 51 milliseconds Apr 19 14:07:38 volumio volumio[699]: verbose: ControllerMpd::parseTrackInfo Apr 19 14:07:38 volumio volumio[699]: info: ControllerMpd::pushState Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::servicePushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79,"duration":260,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"变色感情","artist":"徐小凤","album":"极品之选","uri":"USB/music/Music/【SACD、DSD、ISO】/港台/徐小凤/极品之选/16.变色感情.dsf","trackType":"dsf"} Apr 19 14:07:38 volumio volumio[699]: verbose: CURRENT POSITION 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState stateService play Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::syncState currentStatus play Apr 19 14:07:38 volumio volumio[699]: info: Received an update from plugin. extracting info from payload Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: CoreStateMachine::pushState Apr 19 14:07:38 volumio volumio[699]: info: CorePlayQueue::getTrack 15 Apr 19 14:07:38 volumio volumio[699]: info: CoreCommandRouter::volumioPushState Apr 19 14:07:38 volumio volumio[699]: info: ------------------------------ 141ms Apr 19 14:07:39 volumio volumio[699]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 14:07:39 volumio volumio[699]: Error: connect ETIMEDOUT 199.96.62.17:80 Apr 19 14:07:39 volumio volumio[699]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 19 14:07:39 volumio volumio[699]: errno: -110, Apr 19 14:07:39 volumio volumio[699]: code: 'ETIMEDOUT', Apr 19 14:07:39 volumio volumio[699]: syscall: 'connect', Apr 19 14:07:39 volumio volumio[699]: address: '199.96.62.17', Apr 19 14:07:39 volumio volumio[699]: port: 80 Apr 19 14:07:39 volumio volumio[699]: } Apr 19 14:07:39 volumio volumio[699]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 14:07:39 volumio sudo[1714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-19 14:06 Apr 19 14:07:39 volumio sudo[1714]: 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="68644ecc3d95554759c26a672c9f9845659ebf49" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="d1eed292e757ec0ddcc4830aa293d402cdfd9c92" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 06 Mar 2023 10:42:18 AM CET" VOLUMIO_VERSION="3.435" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cb521a82390d29f21453532486094e99"