-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-12-18 09:37:32 CST. -- Dec 18 09:36:00 smsl-n100 sudo[7204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 09:36:00 smsl-n100 sudo[7204]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 09:36:00 smsl-n100 systemd[1]: Stopping MPD Monitor Service... Dec 18 09:36:00 smsl-n100 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 18 09:36:00 smsl-n100 systemd[1]: mpd_monitor.service: Succeeded. Dec 18 09:36:00 smsl-n100 sudo[7207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 09:36:00 smsl-n100 systemd[1]: Stopped MPD Monitor Service. Dec 18 09:36:00 smsl-n100 sudo[7207]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 09:36:00 smsl-n100 systemd[1]: Started MPD Monitor Service. Dec 18 09:36:00 smsl-n100 sudo[7204]: pam_unix(sudo:session): session closed for user root Dec 18 09:36:00 smsl-n100 mpd_monitor.sh[7211]: MPD Monitor Service: Starting MPD Monitor Service Dec 18 09:36:00 smsl-n100 sudo[7210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 09:36:00 smsl-n100 sudo[7210]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 09:36:00 smsl-n100 systemd[1]: Stopping MPD Monitor Service... Dec 18 09:36:00 smsl-n100 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 18 09:36:00 smsl-n100 systemd[1]: mpd_monitor.service: Succeeded. Dec 18 09:36:00 smsl-n100 systemd[1]: Stopped MPD Monitor Service. Dec 18 09:36:00 smsl-n100 volumio[898]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 18 09:36:00 smsl-n100 volumio[898]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 18 09:36:00 smsl-n100 volumio[898]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 18 09:36:00 smsl-n100 systemd[1]: Started MPD Monitor Service. Dec 18 09:36:00 smsl-n100 volumio[898]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 18 09:36:00 smsl-n100 sudo[7207]: pam_unix(sudo:session): session closed for user root Dec 18 09:36:00 smsl-n100 sudo[7210]: pam_unix(sudo:session): session closed for user root Dec 18 09:36:00 smsl-n100 volumio[898]: info: Successfully started MPD Monitor Dec 18 09:36:00 smsl-n100 volumio[898]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 18 09:36:00 smsl-n100 mpd_monitor.sh[7216]: MPD Monitor Service: Starting MPD Monitor Service Dec 18 09:36:00 smsl-n100 sudo[7215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 18 09:36:00 smsl-n100 sudo[7215]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 18 09:36:00 smsl-n100 volumio[898]: info: Successfully started MPD Monitor Dec 18 09:36:00 smsl-n100 volumio[898]: info: Successfully started MPD Monitor Dec 18 09:36:01 smsl-n100 systemd[1]: Stopping MPD Monitor Service... Dec 18 09:36:01 smsl-n100 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 18 09:36:01 smsl-n100 systemd[1]: mpd_monitor.service: Succeeded. Dec 18 09:36:01 smsl-n100 volumio[898]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 18 09:36:01 smsl-n100 systemd[1]: Stopped MPD Monitor Service. Dec 18 09:36:01 smsl-n100 volumio[898]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 18 09:36:01 smsl-n100 systemd[1]: Started MPD Monitor Service. Dec 18 09:36:01 smsl-n100 sudo[7215]: pam_unix(sudo:session): session closed for user root Dec 18 09:36:01 smsl-n100 volumio[898]: info: Successfully started MPD Monitor Dec 18 09:36:01 smsl-n100 mpd_monitor.sh[7221]: MPD Monitor Service: Starting MPD Monitor Service Dec 18 09:36:06 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 18 09:36:06 smsl-n100 volumio[898]: info: CURURI: music-library Dec 18 09:36:06 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:07 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 18 09:36:07 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand update Dec 18 09:36:07 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:07 smsl-n100 volumio[898]: info: Dec 18 09:36:07 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: update Dec 18 09:36:07 smsl-n100 volumio[898]: info: sendMpdCommand update took 11 milliseconds Dec 18 09:36:07 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:07 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:07 smsl-n100 volumio[898]: info: sendMpdCommand status took 8 milliseconds Dec 18 09:36:07 smsl-n100 volumio[898]: info: sendMpdCommand status took 4 milliseconds Dec 18 09:36:07 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:08 smsl-n100 volumio[898]: info: Command Router : Notfying DB Updatetrue Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::Close All Modals sent Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:08 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:08 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: CURRENT POSITION 3 Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus pause Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:08 smsl-n100 volumio[898]: info: ------------------------------ 938ms Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:08 smsl-n100 volumio[898]: info: Dec 18 09:36:08 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: update Dec 18 09:36:08 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:08 smsl-n100 volumio[898]: info: Dec 18 09:36:08 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: update Dec 18 09:36:08 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:08 smsl-n100 volumio[898]: info: Dec 18 09:36:08 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: update Dec 18 09:36:08 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:08 smsl-n100 volumio[898]: info: Dec 18 09:36:08 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: update Dec 18 09:36:08 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:08 smsl-n100 volumio[898]: info: sendMpdCommand status took 22 milliseconds Dec 18 09:36:08 smsl-n100 volumio[898]: info: sendMpdCommand status took 19 milliseconds Dec 18 09:36:08 smsl-n100 volumio[898]: info: sendMpdCommand status took 18 milliseconds Dec 18 09:36:08 smsl-n100 volumio[898]: info: sendMpdCommand status took 16 milliseconds Dec 18 09:36:08 smsl-n100 volumio[898]: info: sendMpdCommand status took 15 milliseconds Dec 18 09:36:08 smsl-n100 volumio[898]: info: sendMpdCommand status took 14 milliseconds Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:08 smsl-n100 volumio[898]: info: Command Router : Notfying DB Updatefalse Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::Close All Modals sent Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:08 smsl-n100 volumio[898]: info: Command Router : Notfying DB Updatefalse Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::Close All Modals sent Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:08 smsl-n100 volumio[898]: info: Command Router : Notfying DB Updatefalse Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::Close All Modals sent Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:08 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:08 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:08 smsl-n100 volumio[898]: verbose: CURRENT POSITION 3 Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus pause Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:08 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:08 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:08 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: CURRENT POSITION 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus pause Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: CURRENT POSITION 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus pause Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: ------------------------------ 300ms Dec 18 09:36:09 smsl-n100 volumio[898]: info: ------------------------------ 298ms Dec 18 09:36:09 smsl-n100 volumio[898]: info: ------------------------------ 295ms Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:09 smsl-n100 volumio[898]: info: Dec 18 09:36:09 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: update Dec 18 09:36:09 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:09 smsl-n100 volumio[898]: info: Dec 18 09:36:09 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: update Dec 18 09:36:09 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:09 smsl-n100 volumio[898]: info: Dec 18 09:36:09 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: update Dec 18 09:36:09 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:09 smsl-n100 volumio[898]: info: sendMpdCommand status took 356 milliseconds Dec 18 09:36:09 smsl-n100 volumio[898]: info: sendMpdCommand status took 354 milliseconds Dec 18 09:36:09 smsl-n100 volumio[898]: info: sendMpdCommand status took 67 milliseconds Dec 18 09:36:09 smsl-n100 volumio[898]: info: sendMpdCommand status took 65 milliseconds Dec 18 09:36:09 smsl-n100 volumio[898]: info: sendMpdCommand status took 64 milliseconds Dec 18 09:36:09 smsl-n100 volumio[898]: info: sendMpdCommand status took 61 milliseconds Dec 18 09:36:09 smsl-n100 volumio[898]: info: sendMpdCommand status took 60 milliseconds Dec 18 09:36:09 smsl-n100 volumio[898]: info: sendMpdCommand status took 57 milliseconds Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:09 smsl-n100 volumio[898]: info: Command Router : Notfying DB Updatefalse Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::Close All Modals sent Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:09 smsl-n100 volumio[898]: info: Command Router : Notfying DB Updatefalse Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::Close All Modals sent Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:09 smsl-n100 volumio[898]: info: Command Router : Notfying DB Updatefalse Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::Close All Modals sent Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:09 smsl-n100 volumio[898]: info: Command Router : Notfying DB Updatefalse Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::Close All Modals sent Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:09 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: CURRENT POSITION 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus pause Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: CURRENT POSITION 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus pause Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: CURRENT POSITION 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus pause Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:09 smsl-n100 volumio[898]: verbose: CURRENT POSITION 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus pause Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:09 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:09 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:09 smsl-n100 volumio[898]: info: ------------------------------ 711ms Dec 18 09:36:09 smsl-n100 volumio[898]: info: ------------------------------ 422ms Dec 18 09:36:09 smsl-n100 volumio[898]: info: ------------------------------ 419ms Dec 18 09:36:09 smsl-n100 volumio[898]: info: ------------------------------ 416ms Dec 18 09:36:14 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 18 09:36:14 smsl-n100 volumio[898]: info: CURURI: music-library/USB Dec 18 09:36:14 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:15 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 18 09:36:15 smsl-n100 volumio[898]: info: CURURI: music-library/USB/16D42F9FD42F805B Dec 18 09:36:15 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:18 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::ClearQueue Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::stPlaybackTimer Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::serviceStop Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 3 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::serviceStop Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::stop Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::clearPlayQueue Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:36:18 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/加州旅馆.wav Dec 18 09:36:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/加州旅馆.wav Dec 18 09:36:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav Dec 18 09:36:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav Dec 18 09:36:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/yinliangzhayin 歳月-雲流れ-.wav Dec 18 09:36:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/yinliangzhayin 歳月-雲流れ-.wav Dec 18 09:36:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/蔡琴 - 渡口.wav Dec 18 09:36:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/蔡琴 - 渡口.wav Dec 18 09:36:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac Dec 18 09:36:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPlay Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::play index 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::play index undefined Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::startPlaybackTimer Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::clearAddPlayTracks USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand stop took 72 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand stop took 23 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand clear Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand clear took 7 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand add "USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac" Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:18 smsl-n100 volumio[898]: error: updateQueue error: null Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 23ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand add "USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac" took 20 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 19ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 16ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 14ms Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand play Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 43ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand play took 37 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 33ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 29ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 25ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 34 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 30 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 18 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 14 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 10 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:18 smsl-n100 volumio[898]: info: Dec 18 09:36:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 43 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 43 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 40 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 32 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 18 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 13 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":87,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"琵琶对萨克斯","artist":"发烧试音碟","album":"金耳朵","uri":"USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac","trackType":"flac"} Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":87,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"琵琶对萨克斯","artist":"发烧试音碟","album":"金耳朵","uri":"USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac","trackType":"flac"} Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:18 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":87,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"琵琶对萨克斯","artist":"发烧试音碟","album":"金耳朵","uri":"USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac","trackType":"flac"} Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:18 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":87,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"琵琶对萨克斯","artist":"发烧试音碟","album":"金耳朵","uri":"USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac","trackType":"flac"} Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:18 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":87,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"琵琶对萨克斯","artist":"发烧试音碟","album":"金耳朵","uri":"USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac","trackType":"flac"} Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:18 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 207ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 259ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 241ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 237ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 233ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 162 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 161 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 161 milliseconds Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":87,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"琵琶对萨克斯","artist":"发烧试音碟","album":"金耳朵","uri":"USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac","trackType":"flac"} Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:18 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":87,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"琵琶对萨克斯","artist":"发烧试音碟","album":"金耳朵","uri":"USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac","trackType":"flac"} Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:18 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":87,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"琵琶对萨克斯","artist":"发烧试音碟","album":"金耳朵","uri":"USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac","trackType":"flac"} Dec 18 09:36:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:18 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 319ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 307ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: ------------------------------ 303ms Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:18 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:18 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 18 09:36:18 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:18 smsl-n100 volumio[898]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 18 09:36:23 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 18 09:36:23 smsl-n100 volumio[898]: info: CURURI: music-library/USB/KINGSTON Dec 18 09:36:23 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:38 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::ClearQueue Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::stPlaybackTimer Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::serviceStop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 4 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::serviceStop Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::stop Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::clearPlayQueue Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:36:38 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/(9) 768k.wav Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/(9) 768k.wav Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -10dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -10dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -20dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -20dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -3dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -3dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -60dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -60dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -6dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -6dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz 0dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz 0dBFS.WAV Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/左右声道测试 - 副本.wav Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/左右声道测试 - 副本.wav Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/左右声道测试.wav Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/左右声道测试.wav Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/63372200381090822.flac Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/63372200381090822.flac Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/梁静茹 - 勇气.mp3 Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/梁静茹 - 勇气.mp3 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPlay Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::play index 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:36:38 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/月半小夜曲.flac Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/月半小夜曲.flac Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/01 - 千千闕歌.flac Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/01 - 千千闕歌.flac Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/测试曲目 Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/测试曲目 Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/LOST.DIR Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/LOST.DIR Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Android Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Android Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(1) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(1) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(2) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(2) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(3) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(3) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(4) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(4) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(5) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(5) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(6) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(6) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(7) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(7) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(8) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(8) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(21) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(21) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(9) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(9) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(10) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(10) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(11) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(11) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(12) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(12) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(13) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(13) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(14) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(14) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(15) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(15) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(16) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(16) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(17) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(17) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(18) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(18) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(19) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(19) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(20) Dec 18 09:36:38 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(20) Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::play index undefined Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::startPlaybackTimer Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/梁静茹 - 勇气.mp3 Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand stop took 129 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand stop took 27 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand clear Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand status took 21 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand clear took 18 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand status took 16 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand status took 13 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand status took 10 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/梁静茹 - 勇气.mp3" Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: No code Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: No code Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: No code Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 161ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 159ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 158ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:38 smsl-n100 volumio[898]: error: updateQueue error: null Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 170ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 164 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand add "USB/KINGSTON/梁静茹 - 勇气.mp3" took 163 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 19ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 16ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 13ms Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand play Dec 18 09:36:38 smsl-n100 volumio[898]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 201ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 104ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: sendMpdCommand play took 96 milliseconds Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 94ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 90ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: ------------------------------ 88ms Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: Dec 18 09:36:38 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:38 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:38 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:38 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:38 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:38 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:38 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 18 09:36:38 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:38 smsl-n100 volumio[898]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand status took 78 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand status took 76 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand status took 71 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand status took 67 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand status took 63 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:39 smsl-n100 volumio[898]: info: Dec 18 09:36:39 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:39 smsl-n100 volumio[898]: info: Dec 18 09:36:39 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 43 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 41 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 40 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand status took 33 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand status took 29 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"勇气","artist":"梁静茹","album":"国语经典","uri":"USB/KINGSTON/梁静茹 - 勇气.mp3","trackType":"mp3"} Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"勇气","artist":"梁静茹","album":"国语经典","uri":"USB/KINGSTON/梁静茹 - 勇气.mp3","trackType":"mp3"} Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:39 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"勇气","artist":"梁静茹","album":"国语经典","uri":"USB/KINGSTON/梁静茹 - 勇气.mp3","trackType":"mp3"} Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:39 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"勇气","artist":"梁静茹","album":"国语经典","uri":"USB/KINGSTON/梁静茹 - 勇气.mp3","trackType":"mp3"} Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:39 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"勇气","artist":"梁静茹","album":"国语经典","uri":"USB/KINGSTON/梁静茹 - 勇气.mp3","trackType":"mp3"} Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:39 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: ------------------------------ 234ms Dec 18 09:36:39 smsl-n100 volumio[898]: info: ------------------------------ 290ms Dec 18 09:36:39 smsl-n100 volumio[898]: info: ------------------------------ 280ms Dec 18 09:36:39 smsl-n100 volumio[898]: info: ------------------------------ 277ms Dec 18 09:36:39 smsl-n100 volumio[898]: info: ------------------------------ 274ms Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 171 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 170 milliseconds Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"勇气","artist":"梁静茹","album":"国语经典","uri":"USB/KINGSTON/梁静茹 - 勇气.mp3","trackType":"mp3"} Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:39 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"勇气","artist":"梁静茹","album":"国语经典","uri":"USB/KINGSTON/梁静茹 - 勇气.mp3","trackType":"mp3"} Dec 18 09:36:39 smsl-n100 volumio[898]: verbose: CURRENT POSITION 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:39 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: info: ------------------------------ 295ms Dec 18 09:36:39 smsl-n100 volumio[898]: info: ------------------------------ 292ms Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:39 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:39 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:39 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:39 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 18 09:36:39 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:39 smsl-n100 volumio[898]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 18 09:36:40 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 18 09:36:40 smsl-n100 volumio[898]: info: CURURI: music-library/USB/16D42F9FD42F805B Dec 18 09:36:40 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:46 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::ClearQueue Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::stPlaybackTimer Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::serviceStop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 10 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::serviceStop Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::stop Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::clearPlayQueue Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:36:46 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:46 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/加州旅馆.wav Dec 18 09:36:46 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/加州旅馆.wav Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPlay Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::play index 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:36:46 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:46 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav Dec 18 09:36:46 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav Dec 18 09:36:46 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/yinliangzhayin 歳月-雲流れ-.wav Dec 18 09:36:46 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/yinliangzhayin 歳月-雲流れ-.wav Dec 18 09:36:46 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/蔡琴 - 渡口.wav Dec 18 09:36:46 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/蔡琴 - 渡口.wav Dec 18 09:36:46 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac Dec 18 09:36:46 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::play index undefined Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::startPlaybackTimer Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::clearAddPlayTracks USB/16D42F9FD42F805B/加州旅馆.wav Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand stop took 94 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand stop took 24 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand clear Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 22 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand clear took 20 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 18 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 14 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 11 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand add "USB/16D42F9FD42F805B/加州旅馆.wav" Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: No code Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: No code Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: No code Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 166ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 164ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 163ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:46 smsl-n100 volumio[898]: error: updateQueue error: null Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 181ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 174 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand add "USB/16D42F9FD42F805B/加州旅馆.wav" took 174 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 25ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 23ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 20ms Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand play Dec 18 09:36:46 smsl-n100 volumio[898]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 213ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 131ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand play took 122 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 120ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 117ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: ------------------------------ 110ms Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 28 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 27 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 20 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 16 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 13 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:46 smsl-n100 volumio[898]: info: Dec 18 09:36:46 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:46 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:46 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:46 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 18 09:36:46 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:46 smsl-n100 volumio[898]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 63 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 63 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: info: sendMpdCommand status took 58 milliseconds Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:46 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:46 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":433,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/16D42F9FD42F805B/加州旅馆.wav","trackType":"wav"} Dec 18 09:36:46 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:46 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:47 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":433,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/16D42F9FD42F805B/加州旅馆.wav","trackType":"wav"} Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:47 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":433,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/16D42F9FD42F805B/加州旅馆.wav","trackType":"wav"} Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:47 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":433,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/16D42F9FD42F805B/加州旅馆.wav","trackType":"wav"} Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:47 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":433,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/16D42F9FD42F805B/加州旅馆.wav","trackType":"wav"} Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:47 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: ------------------------------ 221ms Dec 18 09:36:47 smsl-n100 volumio[898]: info: ------------------------------ 267ms Dec 18 09:36:47 smsl-n100 volumio[898]: info: ------------------------------ 256ms Dec 18 09:36:47 smsl-n100 volumio[898]: info: ------------------------------ 253ms Dec 18 09:36:47 smsl-n100 volumio[898]: info: ------------------------------ 251ms Dec 18 09:36:47 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 270 milliseconds Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:47 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":433,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/16D42F9FD42F805B/加州旅馆.wav","trackType":"wav"} Dec 18 09:36:47 smsl-n100 volumio[898]: verbose: CURRENT POSITION 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:47 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: info: ------------------------------ 379ms Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:47 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:47 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:47 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:47 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 18 09:36:47 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:47 smsl-n100 volumio[898]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 18 09:36:57 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::ClearQueue Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::stPlaybackTimer Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::serviceStop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 0 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::serviceStop Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::stop Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::clearPlayQueue Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:36:57 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:57 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/加州旅馆.wav Dec 18 09:36:57 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/加州旅馆.wav Dec 18 09:36:57 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav Dec 18 09:36:57 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPlay Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::play index 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:36:57 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:36:57 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/yinliangzhayin 歳月-雲流れ-.wav Dec 18 09:36:57 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/yinliangzhayin 歳月-雲流れ-.wav Dec 18 09:36:57 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/蔡琴 - 渡口.wav Dec 18 09:36:57 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/蔡琴 - 渡口.wav Dec 18 09:36:57 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac Dec 18 09:36:57 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/16D42F9FD42F805B/发烧试音碟 - 琵琶对萨克斯.flac Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::play index undefined Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::startPlaybackTimer Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::clearAddPlayTracks USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand stop took 80 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand stop took 21 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand clear Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 20 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand clear took 18 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 15 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 12 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 9 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand add "USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav" Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: No code Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: No code Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: No code Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 164ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 163ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 162ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:57 smsl-n100 volumio[898]: error: updateQueue error: null Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 178ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 171 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand add "USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav" took 171 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 22ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 20ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 17ms Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand play Dec 18 09:36:57 smsl-n100 volumio[898]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 208ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 118ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand play took 109 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 108ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 106ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 102ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 36 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 35 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 27 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 23 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 19 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: Dec 18 09:36:57 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:57 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 18 09:36:57 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:36:57 smsl-n100 volumio[898]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 57 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 57 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 57 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 56 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 56 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 51 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: info: sendMpdCommand status took 48 milliseconds Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":308,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????????","artist":"????","album":"?? ??? ????","uri":"USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav","trackType":"wav"} Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":308,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????????","artist":"????","album":"?? ??? ????","uri":"USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav","trackType":"wav"} Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:57 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":308,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????????","artist":"????","album":"?? ??? ????","uri":"USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav","trackType":"wav"} Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:57 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":308,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????????","artist":"????","album":"?? ??? ????","uri":"USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav","trackType":"wav"} Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:57 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":308,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????????","artist":"????","album":"?? ??? ????","uri":"USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav","trackType":"wav"} Dec 18 09:36:57 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:57 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:57 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:57 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 222ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 275ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 260ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 257ms Dec 18 09:36:57 smsl-n100 volumio[898]: info: ------------------------------ 253ms Dec 18 09:36:58 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 275 milliseconds Dec 18 09:36:58 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 274 milliseconds Dec 18 09:36:58 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:58 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:36:58 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:58 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":308,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????????","artist":"????","album":"?? ??? ????","uri":"USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav","trackType":"wav"} Dec 18 09:36:58 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:58 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:58 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:58 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:58 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:58 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":308,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????????","artist":"????","album":"?? ??? ????","uri":"USB/16D42F9FD42F805B/Yinliangzhayin 呪われた神州平原.wav","trackType":"wav"} Dec 18 09:36:58 smsl-n100 volumio[898]: verbose: CURRENT POSITION 1 Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:36:58 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:58 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:36:58 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:36:58 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:36:58 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:36:58 smsl-n100 volumio[898]: info: ------------------------------ 420ms Dec 18 09:36:58 smsl-n100 volumio[898]: info: ------------------------------ 418ms Dec 18 09:37:06 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 18 09:37:06 smsl-n100 volumio[898]: info: CURURI: music-library/USB/KINGSTON Dec 18 09:37:06 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:37:18 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::ClearQueue Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::stPlaybackTimer Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::serviceStop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 1 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::serviceStop Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::stop Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::clearPlayQueue Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:37:18 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/(9) 768k.wav Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/(9) 768k.wav Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -10dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -10dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -20dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -20dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -3dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -3dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -60dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -60dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz -6dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz -6dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Sony 2448 1kHz 0dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Sony 2448 1kHz 0dBFS.WAV Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/左右声道测试 - 副本.wav Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/左右声道测试 - 副本.wav Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/左右声道测试.wav Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/左右声道测试.wav Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/63372200381090822.flac Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/63372200381090822.flac Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPlay Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::play index 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::addQueueItems Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::addQueueItems Dec 18 09:37:18 smsl-n100 volumio[898]: info: Preload queue cleared Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/梁静茹 - 勇气.mp3 Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/梁静茹 - 勇气.mp3 Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/月半小夜曲.flac Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/月半小夜曲.flac Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/01 - 千千闕歌.flac Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/01 - 千千闕歌.flac Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/测试曲目 Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/测试曲目 Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/LOST.DIR Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/LOST.DIR Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/Android Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/Android Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(1) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(1) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(2) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(2) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(3) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(3) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(4) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(4) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(5) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(5) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(6) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(6) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(7) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(7) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(8) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(8) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(21) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(21) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(9) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(9) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(10) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(10) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(11) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(11) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(12) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(12) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(13) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(13) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(14) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(14) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(15) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(15) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(16) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(16) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(17) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(17) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(18) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(18) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(19) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(19) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Adding Item to queue: music-library/USB/KINGSTON/CDDA-bak(20) Dec 18 09:37:18 smsl-n100 volumio[898]: info: Using cached record of: music-library/USB/KINGSTON/CDDA-bak(20) Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushQueue Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::saveQueue Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::play index undefined Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::updateTrackBlock Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrackBlock Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::startPlaybackTimer Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/63372200381090822.flac Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand stop took 135 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand stop took 27 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand clear Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 34 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand clear took 33 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 31 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 19 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 15 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/63372200381090822.flac" Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: No code Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: No code Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: No code Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 188ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 178ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 176ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:37:18 smsl-n100 volumio[898]: error: updateQueue error: null Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 190ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 181 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand add "USB/KINGSTON/63372200381090822.flac" took 181 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 25ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 22ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 19ms Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand play Dec 18 09:37:18 smsl-n100 volumio[898]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 234ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces system playlist update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Ignoring MPD Status Update Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 139ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand play took 131 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 129ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 127ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: ------------------------------ 121ms Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:18 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:37:18 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 18 09:37:18 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:37:18 smsl-n100 volumio[898]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 60 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 60 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 55 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 52 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 48 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:37:18 smsl-n100 volumio[898]: info: Dec 18 09:37:18 smsl-n100 volumio[898]: ---------------------------- MPD announces state update: player Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::getState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 65 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 63 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 63 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: info: sendMpdCommand status took 56 milliseconds Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::parseState Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1345,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus stop Dec 18 09:37:18 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1345,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Dec 18 09:37:18 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:37:18 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:37:18 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:18 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1345,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:37:19 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1471,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:37:19 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1471,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"854 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:37:19 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: ------------------------------ 241ms Dec 18 09:37:19 smsl-n100 volumio[898]: info: ------------------------------ 297ms Dec 18 09:37:19 smsl-n100 volumio[898]: info: ------------------------------ 288ms Dec 18 09:37:19 smsl-n100 volumio[898]: info: ------------------------------ 287ms Dec 18 09:37:19 smsl-n100 volumio[898]: info: ------------------------------ 285ms Dec 18 09:37:19 smsl-n100 volumio[898]: info: sendMpdCommand playlistinfo took 161 milliseconds Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: ControllerMpd::parseTrackInfo Dec 18 09:37:19 smsl-n100 volumio[898]: info: ControllerMpd::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::servicePushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1597,"duration":326,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"742 Kbps","isStreaming":false,"title":"起风了","artist":null,"album":null,"uri":"USB/KINGSTON/63372200381090822.flac","trackType":"flac"} Dec 18 09:37:19 smsl-n100 volumio[898]: verbose: CURRENT POSITION 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::syncState stateService play Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::syncState currentStatus play Dec 18 09:37:19 smsl-n100 volumio[898]: info: Received an update from plugin. extracting info from payload Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: info: ------------------------------ 269ms Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreStateMachine::pushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: CorePlayQueue::getTrack 9 Dec 18 09:37:19 smsl-n100 volumio[898]: info: CoreCommandRouter::volumioPushState Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output update for this device Dec 18 09:37:19 smsl-n100 volumio[898]: info: MRS: Pushing multiroomSync output Dec 18 09:37:19 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:37:19 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 18 09:37:19 smsl-n100 volumio[898]: error: Serial API: Failed to decode command: 100, message: undefined Dec 18 09:37:19 smsl-n100 volumio[898]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 18 09:37:23 smsl-n100 ntpd[5758]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Dec 18 09:37:30 smsl-n100 volumio[898]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 09:37:31 smsl-n100 volumio[898]: Error: connect ETIMEDOUT 108.160.167.167:443 Dec 18 09:37:31 smsl-n100 volumio[898]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 18 09:37:31 smsl-n100 volumio[898]: errno: -110, Dec 18 09:37:31 smsl-n100 volumio[898]: code: 'ETIMEDOUT', Dec 18 09:37:31 smsl-n100 volumio[898]: syscall: 'connect', Dec 18 09:37:31 smsl-n100 volumio[898]: address: '108.160.167.167', Dec 18 09:37:31 smsl-n100 volumio[898]: port: 443 Dec 18 09:37:31 smsl-n100 volumio[898]: } Dec 18 09:37:31 smsl-n100 volumio[898]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 09:37:31 smsl-n100 sudo[7494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-18 09:36 Dec 18 09:37:32 smsl-n100 sudo[7494]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="3441cddd43405c36fe444484553f10f2f5bc830b" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 13 Nov 2025 12:39:08 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="7a92d73f7a04bc7854b1812143743fd4"