-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-06-12 14:41:32 CST. -- Jun 12 14:40:00 smsl-n100 volumio[1223]: info: TidalConnect service stoped! Jun 12 14:40:00 smsl-n100 volumio[1223]: info: TidalConnect service stoped! Jun 12 14:40:00 smsl-n100 volumio[1223]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 12 14:40:00 smsl-n100 volumio[1223]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 12 14:40:00 smsl-n100 volumio[1223]: info: TidalConnect service started! Jun 12 14:40:00 smsl-n100 sudo[3383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 12 14:40:00 smsl-n100 sudo[3383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:00 smsl-n100 sudo[3383]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:01 smsl-n100 volumio[1223]: info: RAAT: Requesting Headphone Status Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:01 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:01 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:01 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: 100, message: undefined Jun 12 14:40:01 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 12 14:40:01 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: 100, message: undefined Jun 12 14:40:01 smsl-n100 volumio[1223]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 12 14:40:01 smsl-n100 volumio[1223]: info: VolumeController::SetAlsaVolume0 Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:40:01 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:01 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:01 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:01 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:02 smsl-n100 mpd[3357]: Jun 12 14:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 12 14:40:02 smsl-n100 systemd[1]: Started Music Player Daemon. Jun 12 14:40:02 smsl-n100 volumio[1223]: error: MPD error: The expression evaluated to a falsy value: Jun 12 14:40:02 smsl-n100 volumio[1223]: assert.ok(self.idling) Jun 12 14:40:02 smsl-n100 volumio[1223]: error: The expression evaluated to a falsy value: Jun 12 14:40:02 smsl-n100 volumio[1223]: assert.ok(self.idling) Jun 12 14:40:02 smsl-n100 volumio[1223]: error: MPD error: The expression evaluated to a falsy value: Jun 12 14:40:02 smsl-n100 volumio[1223]: assert.ok(self.idling) Jun 12 14:40:02 smsl-n100 mpd_monitor.sh[566]: MPD restarted due to no mpc output. Jun 12 14:40:02 smsl-n100 volumio[1223]: error: The expression evaluated to a falsy value: Jun 12 14:40:02 smsl-n100 volumio[1223]: assert.ok(self.idling) Jun 12 14:40:02 smsl-n100 volumio[1223]: error: MPD error: The expression evaluated to a falsy value: Jun 12 14:40:02 smsl-n100 volumio[1223]: assert.ok(self.idling) Jun 12 14:40:02 smsl-n100 volumio[1223]: error: The expression evaluated to a falsy value: Jun 12 14:40:02 smsl-n100 volumio[1223]: assert.ok(self.idling) Jun 12 14:40:02 smsl-n100 volumio[1223]: error: updateQueue error: null Jun 12 14:40:02 smsl-n100 volumio[1223]: info: TidalConnect service started! Jun 12 14:40:03 smsl-n100 volumio[1223]: info: TidalConnect service started! Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 14:40:22 smsl-n100 volumio[1223]: xcb_connection_has_error() returned true Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 12 14:40:22 smsl-n100 volumio[1223]: xcb_connection_has_error() returned true Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 12 14:40:22 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 12 14:40:31 smsl-n100 volumio[1223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%B3%E6%85%A7%E5%AB%BB/%E6%B0%B8%E9%81%A0%E6%98%AF%E4%BD%A0%E7%9A%84%E9%99%B3%E6%85%A7%E5%AB%BB%20%5B%E7%89%B9%E5%88%A5%E7%89%88%5D%20%5BMQS%5D/72dda9d3-841b-498d-97b1-8291c43a57d3.jpg' Jun 12 14:40:32 smsl-n100 sudo[3447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 12 14:40:32 smsl-n100 sudo[3447]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:32 smsl-n100 sudo[3447]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:32 smsl-n100 sudo[3450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 12 14:40:32 smsl-n100 sudo[3450]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:32 smsl-n100 sudo[3450]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:32 smsl-n100 volumio[1223]: verbose: New Socket.io Connection to 192.168.0.118 from 192.168.0.11 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 9 Jun 12 14:40:32 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 12 14:40:32 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioGetVisibleSources Jun 12 14:40:32 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 12 14:40:32 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioGetState Jun 12 14:40:32 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 12 14:40:33 smsl-n100 volumio[1223]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 12 14:40:33 smsl-n100 volumio[1223]: info: Received Get System Info Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 14:40:33 smsl-n100 volumio[1223]: info: Discovery: Getting this device information Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioGetState Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioGetState Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:33 smsl-n100 volumio[1223]: info: Listing playlists Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 12 14:40:33 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 12 14:40:33 smsl-n100 volumio[1223]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%B3%E6%85%A7%E5%AB%BB/%E6%B0%B8%E9%81%A0%E6%98%AF%E4%BD%A0%E7%9A%84%E9%99%B3%E6%85%A7%E5%AB%BB%20%5B%E7%89%B9%E5%88%A5%E7%89%88%5D%20%5BMQS%5D/72dda9d3-841b-498d-97b1-8291c43a57d3.jpg' Jun 12 14:40:34 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 12 14:40:34 smsl-n100 volumio[1223]: info: Received Get System Info Jun 12 14:40:34 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 14:40:34 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 14:40:34 smsl-n100 volumio[1223]: info: Discovery: Getting this device information Jun 12 14:40:34 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioGetState Jun 12 14:40:34 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:34 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 14:40:34 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 14:40:38 smsl-n100 volumio[1223]: xcb_connection_has_error() returned true Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 12 14:40:38 smsl-n100 volumio[1223]: xcb_connection_has_error() returned true Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 12 14:40:38 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 12 14:40:42 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 12 14:40:43 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioGetQueue Jun 12 14:40:43 smsl-n100 volumio[1223]: info: CoreStateMachine::getQueue Jun 12 14:40:43 smsl-n100 volumio[1223]: info: CorePlayQueue::getQueue Jun 12 14:40:45 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 12 14:40:45 smsl-n100 volumio[1223]: info: CURURI: music-library Jun 12 14:40:45 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:40:48 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 12 14:40:48 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand update Jun 12 14:40:48 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:48 smsl-n100 volumio[1223]: info: Jun 12 14:40:48 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: update Jun 12 14:40:48 smsl-n100 volumio[1223]: info: sendMpdCommand update took 14 milliseconds Jun 12 14:40:48 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:40:48 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:48 smsl-n100 volumio[1223]: info: sendMpdCommand status took 9 milliseconds Jun 12 14:40:48 smsl-n100 volumio[1223]: info: sendMpdCommand status took 5 milliseconds Jun 12 14:40:48 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:48 smsl-n100 volumio[1223]: info: Command Router : Notfying DB Updatetrue Jun 12 14:40:48 smsl-n100 volumio[1223]: info: CoreCommandRouter::Close All Modals sent Jun 12 14:40:48 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus pause Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ------------------------------ 160ms Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Jun 12 14:40:49 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: update Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Jun 12 14:40:49 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: update Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Jun 12 14:40:49 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: update Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Jun 12 14:40:49 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: update Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 24 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 21 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 19 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 17 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 16 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 13 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Command Router : Notfying DB Updatefalse Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::Close All Modals sent Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Command Router : Notfying DB Updatefalse Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::Close All Modals sent Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Command Router : Notfying DB Updatefalse Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::Close All Modals sent Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus pause Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus pause Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus pause Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ------------------------------ 341ms Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ------------------------------ 337ms Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ------------------------------ 333ms Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Jun 12 14:40:49 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: update Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Jun 12 14:40:49 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: update Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Jun 12 14:40:49 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: update Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 455 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 452 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 126 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 124 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 122 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 120 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 118 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: info: sendMpdCommand status took 116 milliseconds Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Command Router : Notfying DB Updatefalse Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::Close All Modals sent Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Command Router : Notfying DB Updatefalse Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::Close All Modals sent Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Command Router : Notfying DB Updatefalse Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::Close All Modals sent Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: Command Router : Notfying DB Updatefalse Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::Close All Modals sent Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus pause Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus pause Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus pause Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:40:49 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus pause Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:40:49 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:40:49 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ------------------------------ 902ms Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ------------------------------ 573ms Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ------------------------------ 570ms Jun 12 14:40:49 smsl-n100 volumio[1223]: info: ------------------------------ 566ms Jun 12 14:40:50 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:50 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:50 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:50 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:50 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:50 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:50 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:50 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 14:40:54 smsl-n100 volumio[1223]: xcb_connection_has_error() returned true Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 12 14:40:54 smsl-n100 volumio[1223]: xcb_connection_has_error() returned true Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 12 14:40:54 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 12 14:40:57 smsl-n100 volumio[1223]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 14:40:58 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 12 14:40:58 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jun 12 14:40:58 smsl-n100 sudo[3553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jun 12 14:40:58 smsl-n100 sudo[3553]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:58 smsl-n100 sudo[3553]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:58 smsl-n100 sudo[3559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 12 14:40:58 smsl-n100 sudo[3559]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:58 smsl-n100 sudo[3559]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:58 smsl-n100 sudo[3567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 12 14:40:58 smsl-n100 sudo[3567]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:58 smsl-n100 sudo[3567]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:58 smsl-n100 sudo[3573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 12 14:40:58 smsl-n100 sudo[3573]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:58 smsl-n100 sudo[3573]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:58 smsl-n100 sudo[3578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 12 14:40:58 smsl-n100 sudo[3578]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:58 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 12 14:40:58 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 12 14:40:58 smsl-n100 sudo[3578]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:58 smsl-n100 sudo[3581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 12 14:40:58 smsl-n100 sudo[3581]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:40:58 smsl-n100 sudo[3581]: pam_unix(sudo:session): session closed for user root Jun 12 14:40:58 smsl-n100 sudo[3585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 12 14:40:58 smsl-n100 sudo[3585]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 14:41:03 smsl-n100 sudo[3585]: pam_unix(sudo:session): session closed for user root Jun 12 14:41:03 smsl-n100 volumio[1223]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 14:41:03 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 14:41:03 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 14:41:03 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 14:41:03 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 12 14:41:04 smsl-n100 volumio[1223]: info: Received Get System Version Jun 12 14:41:04 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 12 14:41:10 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 12 14:41:10 smsl-n100 volumio[1223]: info: CURURI: music-library Jun 12 14:41:10 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:10 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 12 14:41:10 smsl-n100 volumio[1223]: info: CURURI: music-library/USB Jun 12 14:41:10 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:11 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 12 14:41:11 smsl-n100 volumio[1223]: info: CURURI: music-library/USB/kingston Jun 12 14:41:11 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::ClearQueue Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::stop Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::updateTrackBlock Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrackBlock Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::stPlaybackTimer Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::serviceStop Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::serviceStop Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::stop Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand stop Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::clearPlayQueue Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::saveQueue Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushQueue Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::addQueueItems Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::addQueueItems Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/013_DSD64 天使.dff Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/013_DSD64 天使.dff Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/014_DSD128 5.6 MHZ兄弟抱一下.dsf Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/014_DSD128 5.6 MHZ兄弟抱一下.dsf Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/015_7.dff Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/015_7.dff Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/016_DSD512.dff Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/016_DSD512.dff Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/019_SW_滚滚红尘.wav Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/019_SW_滚滚红尘.wav Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/02左右声道测试.wav Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/02左右声道测试.wav Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushQueue Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::saveQueue Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::updateTrackBlock Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrackBlock Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPlay Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::play index 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::addQueueItems Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::addQueueItems Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/検品用.mp3 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/検品用.mp3 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/错位星空.flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/错位星空.flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/03 - 甜蜜蜜.flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/03 - 甜蜜蜜.flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/草蜢 - 半点心 [mqms2].flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/草蜢 - 半点心 [mqms2].flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/DSD128 勇气.dsf Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/DSD128 勇气.dsf Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/杨培安 - 爱上你是一个错 [mqms2].flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/杨培安 - 爱上你是一个错 [mqms2].flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/梁静茹 - 勇气.mp3 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/梁静茹 - 勇气.mp3 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/01 - 千千闕歌.flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/01 - 千千闕歌.flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/周传雄 - 青花 [mqms2].flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/周传雄 - 青花 [mqms2].flac Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/kingston/測試曲目 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/kingston/測試曲目 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::stop Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushQueue Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::saveQueue Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::play index undefined Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::updateTrackBlock Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrackBlock Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::startPlaybackTimer Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::clearAddPlayTracks USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand stop Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand stop took 151 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand stop took 42 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand clear Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand clear took 10 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand add "USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3" Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:14 smsl-n100 volumio[1223]: error: updateQueue error: null Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 32ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand add "USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3" took 29 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 27ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 25ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 21ms Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 47ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand play took 40 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 22ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 19ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 17ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand status took 45 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand status took 32 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand status took 17 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand status took 13 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Jun 12 14:41:14 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand status took 49 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 39 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 37 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 37 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 35 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand status took 21 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand status took 18 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand status took 13 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":4861,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","artist":null,"album":null,"uri":"USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","trackType":"mp3"} Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":4861,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","artist":null,"album":null,"uri":"USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","trackType":"mp3"} Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":4861,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","artist":null,"album":null,"uri":"USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","trackType":"mp3"} Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":4861,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","artist":null,"album":null,"uri":"USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","trackType":"mp3"} Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 230ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 268ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 265ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 250ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 184 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 177 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 176 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 175 milliseconds Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":4861,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","artist":null,"album":null,"uri":"USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","trackType":"mp3"} Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1360,"duration":4861,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","artist":null,"album":null,"uri":"USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","trackType":"mp3"} Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1360,"duration":4861,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","artist":null,"album":null,"uri":"USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","trackType":"mp3"} Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1360,"duration":4861,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","artist":null,"album":null,"uri":"USB/kingston/DJ - 中英文沈阳精心打造酒吧嗨曲House慢摇串烧 DJ欧文 - 2017年2月收录.mp3","trackType":"mp3"} Jun 12 14:41:14 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:14 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:14 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:14 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 442ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 411ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 407ms Jun 12 14:41:14 smsl-n100 volumio[1223]: info: ------------------------------ 404ms Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:15 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:15 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:15 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: 100, message: undefined Jun 12 14:41:15 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 12 14:41:15 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: 100, message: undefined Jun 12 14:41:15 smsl-n100 volumio[1223]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 12 14:41:15 smsl-n100 volumio[1223]: info: VolumeController::SetAlsaVolume0 Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:15 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:15 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:15 smsl-n100 volumio[1223]: info: VolumeController::SetAlsaVolume0 Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:15 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:15 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:15 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:15 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:21 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 12 14:41:21 smsl-n100 volumio[1223]: info: CURURI: music-library/USB/KINGSTON Jun 12 14:41:21 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::ClearQueue Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::stPlaybackTimer Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::updateTrackBlock Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrackBlock Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::serviceStop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 6 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::serviceStop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ControllerMpd::stop Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::clearPlayQueue Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::saveQueue Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushQueue Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::addQueueItems Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::addQueueItems Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/(9) 768k.wav Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/(9) 768k.wav Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/左右声道测试.wav Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/左右声道测试.wav Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/63372200381090822.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/63372200381090822.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushQueue Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::saveQueue Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::updateTrackBlock Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrackBlock Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPlay Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::play index 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::addQueueItems Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::addQueueItems Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Preload queue cleared Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/16 - 焚心似火（國語版）.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/16 - 焚心似火（國語版）.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/梁静茹 - 勇气.mp3 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/梁静茹 - 勇气.mp3 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/月半小夜曲.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/月半小夜曲.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/01 - 千千闕歌.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/01 - 千千闕歌.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/测试曲目 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/测试曲目 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/LOST.DIR Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/LOST.DIR Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Adding Item to queue: music-library/USB/KINGSTON/Android Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Using cached record of: music-library/USB/KINGSTON/Android Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushQueue Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::saveQueue Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::play index undefined Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::updateTrackBlock Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrackBlock Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::startPlaybackTimer Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/63372200381090822.flac Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Jun 12 14:41:24 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:24 smsl-n100 volumio[1223]: info: sendMpdCommand stop took 127 milliseconds Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:24 smsl-n100 volumio[1223]: info: sendMpdCommand stop took 30 milliseconds Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand clear Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Jun 12 14:41:24 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Jun 12 14:41:24 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Jun 12 14:41:24 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Jun 12 14:41:24 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:24 smsl-n100 volumio[1223]: info: sendMpdCommand status took 29 milliseconds Jun 12 14:41:24 smsl-n100 volumio[1223]: info: sendMpdCommand clear took 27 milliseconds Jun 12 14:41:24 smsl-n100 volumio[1223]: info: sendMpdCommand status took 21 milliseconds Jun 12 14:41:24 smsl-n100 volumio[1223]: info: sendMpdCommand status took 18 milliseconds Jun 12 14:41:24 smsl-n100 volumio[1223]: info: sendMpdCommand status took 14 milliseconds Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/63372200381090822.flac" Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: No code Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: No code Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 12 14:41:24 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: No code Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:24 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:24 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ------------------------------ 220ms Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ------------------------------ 219ms Jun 12 14:41:24 smsl-n100 volumio[1223]: info: ------------------------------ 216ms Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Jun 12 14:41:24 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Jun 12 14:41:24 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Jun 12 14:41:24 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:24 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:25 smsl-n100 volumio[1223]: error: updateQueue error: null Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 251ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 242 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand add "USB/KINGSTON/63372200381090822.flac" took 242 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 43ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 41ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 38ms Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand play Jun 12 14:41:25 smsl-n100 volumio[1223]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 290ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces system playlist update Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Ignoring MPD Status Update Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 189ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand play took 178 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 175ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 170ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 166ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: 100, message: undefined Jun 12 14:41:25 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 12 14:41:25 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: 100, message: undefined Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand status took 104 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand status took 101 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand status took 97 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand status took 93 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand status took 91 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Jun 12 14:41:25 smsl-n100 volumio[1223]: ---------------------------- MPD announces state update: player Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::getState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 65 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 64 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 63 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 64 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 63 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand status took 63 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand status took 60 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand status took 56 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseState Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1471,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1471,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"854 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1471,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"854 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1471,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"854 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1471,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"854 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 318ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 386ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 378ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 376ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 374ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 218 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 218 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: info: sendMpdCommand playlistinfo took 217 milliseconds Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1723,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"854 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1723,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ControllerMpd::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::servicePushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1723,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Jun 12 14:41:25 smsl-n100 volumio[1223]: verbose: CURRENT POSITION 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState stateService play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:41:25 smsl-n100 volumio[1223]: info: Received an update from plugin. extracting info from payload Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 477ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 475ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: ------------------------------ 474ms Jun 12 14:41:25 smsl-n100 volumio[1223]: info: VolumeController::SetAlsaVolume0 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:25 smsl-n100 volumio[1223]: info: VolumeController::SetAlsaVolume0 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:25 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:25 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:26 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:26 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:26 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:26 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:26 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: 100, message: undefined Jun 12 14:41:26 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 12 14:41:26 smsl-n100 volumio[1223]: error: Serial API: Failed to decode command: 100, message: undefined Jun 12 14:41:26 smsl-n100 volumio[1223]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 12 14:41:26 smsl-n100 volumio[1223]: info: VolumeController::SetAlsaVolume0 Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:26 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:26 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:26 smsl-n100 volumio[1223]: info: VolumeController::SetAlsaVolume0 Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CoreStateMachine::pushState Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CorePlayQueue::getTrack 2 Jun 12 14:41:26 smsl-n100 volumio[1223]: info: CoreCommandRouter::volumioPushState Jun 12 14:41:26 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output update for this device Jun 12 14:41:26 smsl-n100 volumio[1223]: info: MRS: Pushing multiroomSync output Jun 12 14:41:26 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:26 smsl-n100 volumio[1223]: info: Updating RAAT Signal Path Jun 12 14:41:31 smsl-n100 volumio[1223]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 12 14:41:31 smsl-n100 volumio[1223]: Error: connect ETIMEDOUT 69.63.190.26:443 Jun 12 14:41:31 smsl-n100 volumio[1223]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 12 14:41:31 smsl-n100 volumio[1223]: errno: -110, Jun 12 14:41:31 smsl-n100 volumio[1223]: code: 'ETIMEDOUT', Jun 12 14:41:31 smsl-n100 volumio[1223]: syscall: 'connect', Jun 12 14:41:31 smsl-n100 volumio[1223]: address: '69.63.190.26', Jun 12 14:41:31 smsl-n100 volumio[1223]: port: 443 Jun 12 14:41:31 smsl-n100 volumio[1223]: } Jun 12 14:41:31 smsl-n100 volumio[1223]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 12 14:41:32 smsl-n100 sudo[3666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-12 14:40 Jun 12 14:41:32 smsl-n100 sudo[3666]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"