-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-09-11 14:39:34 CST. -- Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:01 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:02 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:07 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:07 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:16 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Clearing queue after UPNP request Sep 11 14:38:19 smsl-n100 volumio[1210]: verbose: UNSET VOLATILE: Service: airplay_emulation Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Stopping Airplay Playback and sending pause command to client via USR2 Sep 11 14:38:19 smsl-n100 sudo[2052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 1627 Sep 11 14:38:19 smsl-n100 sudo[2052]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 11 14:38:19 smsl-n100 sudo[2052]: pam_unix(sudo:session): session closed for user root Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Shairport-Sync paused with USR2 Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::ClearQueue Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::stop Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::stPlaybackTimer Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::updateTrackBlock Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CorePlayQueue::getTrackBlock Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CorePlayQueue::getTrack 0 Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::serviceStop Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CorePlayQueue::getTrack 0 Sep 11 14:38:19 smsl-n100 volumio[1210]: info: ControllerMpd::stop Sep 11 14:38:19 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand stop Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CorePlayQueue::clearPlayQueue Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CorePlayQueue::saveQueue Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushQueue Sep 11 14:38:19 smsl-n100 volumio[1210]: error: Upnp client error: Error: This socket has been ended by the other party Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: Updating RAAT Signal Path Sep 11 14:38:19 smsl-n100 volumio[1210]: info: sendMpdCommand stop took 72 milliseconds Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CorePlayQueue::getTrack 0 Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:19 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:19 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:38:19 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: MAXVOL, message: Sep 11 14:38:19 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:38:19 smsl-n100 volumio[1210]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Sep 11 14:38:20 smsl-n100 volumio[1210]: info: Restarting Shairport-Sync after stop Sep 11 14:38:20 smsl-n100 sudo[2056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 11 14:38:20 smsl-n100 sudo[2056]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 11 14:38:20 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 11 14:38:20 smsl-n100 shairport-sync[1627]: {"time":1757572637121,"response":"startAirplayPlayback Success"} Sep 11 14:38:20 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Sep 11 14:38:20 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 11 14:38:20 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 11 14:38:20 smsl-n100 sudo[2056]: pam_unix(sudo:session): session closed for user root Sep 11 14:38:20 smsl-n100 volumio[1210]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 11 14:38:20 smsl-n100 volumio[1210]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 11 14:38:20 smsl-n100 volumio[1210]: info: Shairport-Sync retarted Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Starting UPNP Playback Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Preparing playback through UPNP Sep 11 14:38:21 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetState Sep 11 14:38:21 smsl-n100 volumio[1210]: info: CorePlayQueue::getTrack 0 Sep 11 14:38:21 smsl-n100 volumio[1210]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 15ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 12ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 8ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 7ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 11ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 6ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 12ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 9ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 11ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 7ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Sep 11 14:38:21 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 9ms Sep 11 14:38:21 smsl-n100 volumio[1210]: info: ------------------------------ 5ms Sep 11 14:38:22 smsl-n100 volumio[1210]: info: Sep 11 14:38:22 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:38:22 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:38:22 smsl-n100 volumio[1210]: info: Sep 11 14:38:22 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:38:22 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:38:22 smsl-n100 volumio[1210]: info: Sep 11 14:38:22 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:38:22 smsl-n100 volumio[1210]: info: sendMpdCommand status took 20 milliseconds Sep 11 14:38:22 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:38:22 smsl-n100 volumio[1210]: info: sendMpdCommand status took 46 milliseconds Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:38:22 smsl-n100 volumio[1210]: info: Sep 11 14:38:22 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:38:22 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:38:22 smsl-n100 volumio[1210]: info: Sep 11 14:38:22 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:22 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:22 smsl-n100 volumio[1210]: info: Sep 11 14:38:22 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:38:22 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:38:22 smsl-n100 volumio[1210]: info: sendMpdCommand status took 59 milliseconds Sep 11 14:38:22 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 43 milliseconds Sep 11 14:38:22 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 38 milliseconds Sep 11 14:38:22 smsl-n100 volumio[1210]: info: sendMpdCommand status took 21 milliseconds Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:38:22 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"失恋阵线联盟","artist":"草蜢","album":"失恋阵线联盟","uri":"http://fsandroid.tx.kugou.com/202509111438/346f314450b427304b7bab305fc91799/v3/e9c204fe9b34419c89bb8e6ee9e71388/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3653243514.mp3","trackType":"mp3"} Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus stop Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"失恋阵线联盟","artist":"草蜢","album":"失恋阵线联盟","uri":"http://fsandroid.tx.kugou.com/202509111438/346f314450b427304b7bab305fc91799/v3/e9c204fe9b34419c89bb8e6ee9e71388/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3653243514.mp3","trackType":"mp3"} Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ------------------------------ 197ms Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ------------------------------ 212ms Sep 11 14:38:23 smsl-n100 volumio[1210]: info: Sep 11 14:38:23 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:38:23 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:38:23 smsl-n100 volumio[1210]: info: Sep 11 14:38:23 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ------------------------------ 133ms Sep 11 14:38:23 smsl-n100 volumio[1210]: info: sendMpdCommand status took 124 milliseconds Sep 11 14:38:23 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 111 milliseconds Sep 11 14:38:23 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 105 milliseconds Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ------------------------------ 17ms Sep 11 14:38:23 smsl-n100 volumio[1210]: info: sendMpdCommand status took 12 milliseconds Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"失恋阵线联盟","artist":"草蜢","album":"失恋阵线联盟","uri":"http://fsandroid.tx.kugou.com/202509111438/346f314450b427304b7bab305fc91799/v3/e9c204fe9b34419c89bb8e6ee9e71388/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3653243514.mp3","trackType":"mp3"} Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"失恋阵线联盟","artist":"草蜢","album":"失恋阵线联盟","uri":"http://fsandroid.tx.kugou.com/202509111438/346f314450b427304b7bab305fc91799/v3/e9c204fe9b34419c89bb8e6ee9e71388/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3653243514.mp3","trackType":"mp3"} Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ------------------------------ 365ms Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ------------------------------ 292ms Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 275 milliseconds Sep 11 14:38:23 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 271 milliseconds Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"失恋阵线联盟","artist":"草蜢","album":"失恋阵线联盟","uri":"http://fsandroid.tx.kugou.com/202509111438/346f314450b427304b7bab305fc91799/v3/e9c204fe9b34419c89bb8e6ee9e71388/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3653243514.mp3","trackType":"mp3"} Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"失恋阵线联盟","artist":"草蜢","album":"失恋阵线联盟","uri":"http://fsandroid.tx.kugou.com/202509111438/346f314450b427304b7bab305fc91799/v3/e9c204fe9b34419c89bb8e6ee9e71388/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3653243514.mp3","trackType":"mp3"} Sep 11 14:38:23 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:38:23 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ------------------------------ 572ms Sep 11 14:38:23 smsl-n100 volumio[1210]: info: ------------------------------ 455ms Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:38:23 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:38:23 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: MAXVOL, message: Sep 11 14:38:23 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:38:23 smsl-n100 volumio[1210]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:38:23 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:15 smsl-n100 volumio[1210]: info: Sep 11 14:39:15 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:15 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:15 smsl-n100 volumio[1210]: info: Sep 11 14:39:15 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:15 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:15 smsl-n100 volumio[1210]: info: sendMpdCommand status took 8 milliseconds Sep 11 14:39:15 smsl-n100 volumio[1210]: info: sendMpdCommand status took 4 milliseconds Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:15 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 11 14:39:15 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:15 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CorePlayQueue::getTrack 0 Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"失恋阵线联盟","artist":"草蜢","album":"失恋阵线联盟","uri":"http://fsandroid.tx.kugou.com/202509111438/346f314450b427304b7bab305fc91799/v3/e9c204fe9b34419c89bb8e6ee9e71388/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3653243514.mp3","trackType":"mp3"} Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService stop Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::stPlaybackTimer Sep 11 14:39:15 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CorePlayQueue::getTrack 0 Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"失恋阵线联盟","artist":"草蜢","album":"失恋阵线联盟","uri":"http://fsandroid.tx.kugou.com/202509111438/346f314450b427304b7bab305fc91799/v3/e9c204fe9b34419c89bb8e6ee9e71388/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3653243514.mp3","trackType":"mp3"} Sep 11 14:39:15 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService stop Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus stop Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:15 smsl-n100 volumio[1210]: info: No code Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:15 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:15 smsl-n100 volumio[1210]: info: ------------------------------ 122ms Sep 11 14:39:15 smsl-n100 volumio[1210]: info: ------------------------------ 119ms Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:15 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:16 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:39:16 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: MAXVOL, message: Sep 11 14:39:16 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:39:16 smsl-n100 volumio[1210]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Sep 11 14:39:16 smsl-n100 volumio[1210]: info: Clearing queue after UPNP request Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreStateMachine::ClearQueue Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreStateMachine::stop Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CorePlayQueue::clearPlayQueue Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CorePlayQueue::saveQueue Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:16 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushQueue Sep 11 14:39:16 smsl-n100 volumio[1210]: info: Sep 11 14:39:16 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:16 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:16 smsl-n100 volumio[1210]: info: Sep 11 14:39:16 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:16 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:16 smsl-n100 volumio[1210]: error: updateQueue error: null Sep 11 14:39:16 smsl-n100 volumio[1210]: error: updateQueue error: null Sep 11 14:39:16 smsl-n100 volumio[1210]: info: ------------------------------ 10ms Sep 11 14:39:16 smsl-n100 volumio[1210]: info: ------------------------------ 8ms Sep 11 14:39:16 smsl-n100 volumio[1210]: info: Starting UPNP Playback Sep 11 14:39:16 smsl-n100 volumio[1210]: info: Preparing playback through UPNP Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetState Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CorePlayQueue::getTrack 0 Sep 11 14:39:16 smsl-n100 volumio[1210]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 12ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 9ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 7ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 8ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 9ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 6ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 8ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 5ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 9ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 5ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 9ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 5ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand status took 22 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand status took 13 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand status took 18 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand status took 10 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"周传雄 - 黄昏","artist":"周传雄","album":null,"uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus stop Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"周传雄 - 黄昏","artist":"周传雄","album":null,"uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 132ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 166ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 135 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 133 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"黄昏","artist":"周传雄","album":"忘记","uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"黄昏","artist":"周传雄","album":"忘记","uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 308ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 295ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces system playlist update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Ignoring MPD Status Update Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 279ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand status took 272 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 125ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand status took 117 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"黄昏","artist":"周传雄","album":"忘记","uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1611,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"黄昏","artist":"周传雄","album":"忘记","uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:17 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 409ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: ------------------------------ 254ms Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:17 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:39:17 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: MAXVOL, message: Sep 11 14:39:17 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:39:17 smsl-n100 volumio[1210]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Sep 11 14:39:17 smsl-n100 volumio[1210]: info: Sep 11 14:39:17 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:18 smsl-n100 volumio[1210]: info: Sep 11 14:39:18 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: sendMpdCommand status took 33 milliseconds Sep 11 14:39:18 smsl-n100 volumio[1210]: info: sendMpdCommand status took 27 milliseconds Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:18 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 11 14:39:18 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1977,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"黄昏","artist":"周传雄","album":"忘记","uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService pause Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::stPlaybackTimer Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1977,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"黄昏","artist":"周传雄","album":"忘记","uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService pause Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::stPlaybackTimer Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ------------------------------ 128ms Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ------------------------------ 122ms Sep 11 14:39:18 smsl-n100 volumio[1210]: info: Sep 11 14:39:18 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:18 smsl-n100 volumio[1210]: info: Sep 11 14:39:18 smsl-n100 volumio[1210]: ---------------------------- MPD announces state update: player Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ControllerMpd::getState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: sendMpdCommand status took 57 milliseconds Sep 11 14:39:18 smsl-n100 volumio[1210]: info: sendMpdCommand status took 49 milliseconds Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:39:18 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 11 14:39:18 smsl-n100 volumio[1210]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3222,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"黄昏","artist":"周传雄","album":"忘记","uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:18 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ControllerMpd::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::servicePushState Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: In UPNP mode Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3222,"duration":344,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"黄昏","artist":"周传雄","album":"忘记","uri":"http://fsandroid.tx.kugou.com/202509111439/4baec6091e4bc2c75bc606d63a98a02a/v3/cbd9a8cfaad5912915cec3fca5d3b8b9/yp/full/ap2590_us1015703285_mi163092287616823127968218826208895467525_pi2_mx0_quviper_tape_ct440100_s3840564220.mp3","trackType":"mp3"} Sep 11 14:39:18 smsl-n100 volumio[1210]: verbose: CURRENT POSITION 0 Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState stateService play Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:39:18 smsl-n100 volumio[1210]: info: Received an update from plugin. extracting info from payload Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ------------------------------ 197ms Sep 11 14:39:18 smsl-n100 volumio[1210]: info: ------------------------------ 188ms Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:18 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:39:18 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: MAXVOL, message: Sep 11 14:39:18 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::pushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioPushState Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output update for this device Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MRS: Pushing multiroomSync output Sep 11 14:39:18 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:39:18 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: MAXVOL, message: Sep 11 14:39:18 smsl-n100 volumio[1210]: error: Serial API: Failed to decode command: 100, message: undefined Sep 11 14:39:18 smsl-n100 volumio[1210]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CoreStateMachine::getQueue Sep 11 14:39:18 smsl-n100 volumio[1210]: info: CorePlayQueue::getQueue Sep 11 14:39:33 smsl-n100 volumio[1210]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 11 14:39:33 smsl-n100 volumio[1210]: Error: connect ETIMEDOUT 103.252.115.153:80 Sep 11 14:39:33 smsl-n100 volumio[1210]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 11 14:39:33 smsl-n100 volumio[1210]: errno: -110, Sep 11 14:39:33 smsl-n100 volumio[1210]: code: 'ETIMEDOUT', Sep 11 14:39:33 smsl-n100 volumio[1210]: syscall: 'connect', Sep 11 14:39:33 smsl-n100 volumio[1210]: address: '103.252.115.153', Sep 11 14:39:33 smsl-n100 volumio[1210]: port: 80 Sep 11 14:39:33 smsl-n100 volumio[1210]: } Sep 11 14:39:33 smsl-n100 volumio[1210]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 11 14:39:34 smsl-n100 sudo[2699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-11 14:38 Sep 11 14:39:34 smsl-n100 sudo[2699]: 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"