-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Fri 2025-06-06 23:58:59 CST. -- Jun 06 23:57:02 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jun 06 23:57:02 volumio-3b sudo[5860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/NAS Jun 06 23:57:02 volumio-3b sudo[5860]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 06 23:57:02 volumio-3b systemd[3669]: mnt-NAS-NAS.mount: Succeeded. Jun 06 23:57:02 volumio-3b systemd[1]: mnt-NAS-NAS.mount: Succeeded. Jun 06 23:57:02 volumio-3b sudo[5860]: pam_unix(sudo:session): session closed for user root Jun 06 23:57:02 volumio-3b volumio[5317]: info: Share NAS successfully unmounted Jun 06 23:57:02 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 06 23:57:03 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 23 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 19 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 17 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 15 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 13 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 12 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:05 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatetrue Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:05 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatetrue Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:05 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatetrue Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: No code Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: No code Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: No code Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:05 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:05 volumio-3b volumio[5317]: info: ------------------------------ 632ms Jun 06 23:57:05 volumio-3b volumio[5317]: info: ------------------------------ 629ms Jun 06 23:57:05 volumio-3b volumio[5317]: info: ------------------------------ 629ms Jun 06 23:57:05 volumio-3b volumio[5317]: info: [1749225425771] Database update started Jun 06 23:57:05 volumio-3b volumio[5317]: info: MPD Database updated - AlbumList cache refreshed Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: database Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: MPD Database updated - AlbumList cache refreshed Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: database Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: MPD Database updated - AlbumList cache refreshed Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: database Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: Jun 06 23:57:05 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 149 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 148 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 147 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 142 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 139 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 138 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 134 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 124 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: info: sendMpdCommand status took 122 milliseconds Jun 06 23:57:05 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:05 volumio-3b kernel: hwmon hwmon1: Undervoltage detected! Jun 06 23:57:06 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: No code Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: No code Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: No code Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: No code Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: No code Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: No code Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:06 volumio-3b volumio[5317]: info: ------------------------------ 892ms Jun 06 23:57:06 volumio-3b volumio[5317]: info: ------------------------------ 892ms Jun 06 23:57:06 volumio-3b volumio[5317]: info: ------------------------------ 886ms Jun 06 23:57:06 volumio-3b volumio[5317]: info: ------------------------------ 887ms Jun 06 23:57:06 volumio-3b volumio[5317]: info: ------------------------------ 879ms Jun 06 23:57:06 volumio-3b volumio[5317]: info: ------------------------------ 881ms Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand rescan Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:06 volumio-3b volumio[5317]: info: Jun 06 23:57:06 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:06 volumio-3b volumio[5317]: info: sendMpdCommand rescan took 6 milliseconds Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:06 volumio-3b volumio[5317]: info: Jun 06 23:57:06 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:06 volumio-3b volumio[5317]: info: Jun 06 23:57:06 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:06 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:06 volumio-3b volumio[5317]: info: sendMpdCommand status took 24 milliseconds Jun 06 23:57:06 volumio-3b volumio[5317]: info: sendMpdCommand status took 21 milliseconds Jun 06 23:57:06 volumio-3b volumio[5317]: info: sendMpdCommand status took 17 milliseconds Jun 06 23:57:06 volumio-3b volumio[5317]: info: sendMpdCommand status took 15 milliseconds Jun 06 23:57:06 volumio-3b volumio[5317]: info: sendMpdCommand status took 13 milliseconds Jun 06 23:57:06 volumio-3b volumio[5317]: info: sendMpdCommand status took 11 milliseconds Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatetrue Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatetrue Jun 06 23:57:06 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:06 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatetrue Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 505ms Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 498ms Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 495ms Jun 06 23:57:07 volumio-3b volumio[5317]: info: MPD Database updated - AlbumList cache refreshed Jun 06 23:57:07 volumio-3b volumio[5317]: info: Jun 06 23:57:07 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: database Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: Jun 06 23:57:07 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: MPD Database updated - AlbumList cache refreshed Jun 06 23:57:07 volumio-3b volumio[5317]: info: Jun 06 23:57:07 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: database Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: Jun 06 23:57:07 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: MPD Database updated - AlbumList cache refreshed Jun 06 23:57:07 volumio-3b volumio[5317]: info: Jun 06 23:57:07 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: database Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: Jun 06 23:57:07 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 77 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 75 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 74 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 69 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 67 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 64 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 60 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 58 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: info: sendMpdCommand status took 57 milliseconds Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:07 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: No code Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:07 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 497ms Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 497ms Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 489ms Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 489ms Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 481ms Jun 06 23:57:07 volumio-3b volumio[5317]: info: ------------------------------ 481ms Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand update Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: info: Jun 06 23:57:08 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand update took 6 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: info: Jun 06 23:57:08 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: info: Jun 06 23:57:08 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: info: Jun 06 23:57:08 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 13 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 11 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 10 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 9 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 9 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: No code Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: No code Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: ------------------------------ 202ms Jun 06 23:57:08 volumio-3b volumio[5317]: info: ------------------------------ 199ms Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: info: Jun 06 23:57:08 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: info: Jun 06 23:57:08 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: update Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 206 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 205 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 203 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 12 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 10 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 10 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: info: sendMpdCommand status took 9 milliseconds Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: info: Command Router : Notfying DB Updatefalse Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: No code Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: No code Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: No code Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:08 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: No code Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:08 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:08 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:09 volumio-3b volumio[5317]: info: ------------------------------ 399ms Jun 06 23:57:09 volumio-3b volumio[5317]: info: ------------------------------ 476ms Jun 06 23:57:09 volumio-3b volumio[5317]: info: ------------------------------ 283ms Jun 06 23:57:09 volumio-3b volumio[5317]: info: ------------------------------ 282ms Jun 06 23:57:10 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 06 23:57:10 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 06 23:57:10 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 06 23:57:10 volumio-3b kernel: hwmon hwmon1: Voltage normalised Jun 06 23:57:10 volumio-3b volumio-remote-updater[596]: Test mode enabled Jun 06 23:57:10 volumio-3b volumio-remote-updater[596]: No alpha test mode Jun 06 23:57:10 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 06 23:57:10 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 06 23:57:11 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 06 23:57:11 volumio-3b volumio[5317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 06 23:57:11 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioGetState Jun 06 23:57:11 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:11 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioGetState Jun 06 23:57:11 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:11 volumio-3b volumio[5317]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 06 23:57:11 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioGetState Jun 06 23:57:16 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioGetBrowseSources Jun 06 23:57:16 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 06 23:57:18 volumio-3b volumio[5317]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jun 06 23:57:18 volumio-3b volumio[5317]: info: Completed starting MyVolumio Plugin Jun 06 23:57:18 volumio-3b volumio[5317]: [Metrics] CommandRouter: 47s 973.44ms Jun 06 23:57:18 volumio-3b volumio[5317]: info: CoreCommandRouter::volumiosetStartupVolume Jun 06 23:57:18 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 23:57:18 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 06 23:57:18 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:18 volumio-3b volumio[5317]: info: CoreCommandRouter::Close All Modals sent Jun 06 23:57:19 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 06 23:57:19 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 06 23:57:19 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 06 23:57:25 volumio-3b volumio[5317]: info: BOOT COMPLETED Jun 06 23:57:25 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPlay Jun 06 23:57:25 volumio-3b volumio[5317]: info: CoreStateMachine::play index undefined Jun 06 23:57:25 volumio-3b volumio[5317]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 06 23:57:25 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:25 volumio-3b volumio[5317]: info: CoreStateMachine::startPlaybackTimer Jun 06 23:57:25 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:25 volumio-3b volumio[5317]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Music/张学友-旧情绵绵.flac Jun 06 23:57:25 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand stop Jun 06 23:57:25 volumio-3b volumio[5317]: info: sendMpdCommand stop took 1 milliseconds Jun 06 23:57:25 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand clear Jun 06 23:57:25 volumio-3b volumio[5317]: info: Jun 06 23:57:25 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:25 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand clear took 2 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Music/张学友-旧情绵绵.flac" Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:26 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:26 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:26 volumio-3b volumio[5317]: error: updateQueue error: null Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:26 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 7ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand add "INTERNAL/Music/张学友-旧情绵绵.flac" took 6 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 6ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 5ms Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand play Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:26 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:26 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 9ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand play took 6 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 7ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 5ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand status took 20 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand status took 22 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand status took 21 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"765 Kbps","isStreaming":false,"title":"旧情绵绵","artist":"张学友","album":"传奇 - 我与你","uri":"INTERNAL/Music/张学友-旧情绵绵.flac","trackType":"flac"} Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 34ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:26 volumio-3b volumio[5317]: info: Jun 06 23:57:26 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand status took 11 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 9 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 9 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand status took 4 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand status took 2 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"754 Kbps","isStreaming":false,"title":"旧情绵绵","artist":"张学友","album":"传奇 - 我与你","uri":"INTERNAL/Music/张学友-旧情绵绵.flac","trackType":"flac"} Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:26 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"925 Kbps","isStreaming":false,"title":"旧情绵绵","artist":"张学友","album":"传奇 - 我与你","uri":"INTERNAL/Music/张学友-旧情绵绵.flac","trackType":"flac"} Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:26 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 111ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 112ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 86 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 85 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 85 milliseconds Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"旧情绵绵","artist":"张学友","album":"传奇 - 我与你","uri":"INTERNAL/Music/张学友-旧情绵绵.flac","trackType":"flac"} Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:26 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"旧情绵绵","artist":"张学友","album":"传奇 - 我与你","uri":"INTERNAL/Music/张学友-旧情绵绵.flac","trackType":"flac"} Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:26 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"旧情绵绵","artist":"张学友","album":"传奇 - 我与你","uri":"INTERNAL/Music/张学友-旧情绵绵.flac","trackType":"flac"} Jun 06 23:57:26 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:26 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:26 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 211ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 204ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: ------------------------------ 204ms Jun 06 23:57:26 volumio-3b volumio[5317]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 06 23:57:31 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 06 23:57:31 volumio-3b volumio[5317]: info: CURURI: music-library/NAS/NAS Jun 06 23:57:31 volumio-3b volumio[5317]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 06 23:57:31 volumio-3b volumio[5317]: info: Preload queue cleared Jun 06 23:57:33 volumio-3b kernel: hwmon hwmon1: Undervoltage detected! Jun 06 23:57:36 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 06 23:57:36 volumio-3b volumio[5317]: info: CURURI: music-library/INTERNAL Jun 06 23:57:36 volumio-3b volumio[5317]: info: Preload queue cleared Jun 06 23:57:37 volumio-3b kernel: hwmon hwmon1: Voltage normalised Jun 06 23:57:37 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 06 23:57:37 volumio-3b volumio[5317]: info: CURURI: music-library/INTERNAL/Music Jun 06 23:57:37 volumio-3b volumio[5317]: info: Preload queue cleared Jun 06 23:57:37 volumio-3b volumio[5317]: info: Preloading song: music-library/INTERNAL/Music/谢霆锋-非走不可.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Preloading song: music-library/INTERNAL/Music/谢霆锋-活着Viva.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Preloading song: music-library/INTERNAL/Music/林子祥-似梦迷离-《一咬O.K.》电影主题曲.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Preloading song: music-library/INTERNAL/Music/张学友-旧情绵绵.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Preloading song: music-library/INTERNAL/Music/谢霆锋-早知.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Preloading song: music-library/INTERNAL/Music/谢霆锋-一击即中.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Exploding uri music-library/INTERNAL/Music/谢霆锋-非走不可.flac in service mpd Jun 06 23:57:37 volumio-3b volumio[5317]: info: ALBUMART /albumart?cacheid=499&web=%E8%B0%A2%E9%9C%86%E9%94%8B/Believe/mega&path=%2Fmnt%2FINTERNAL%2FMusic%2F%E8%B0%A2%E9%9C%86%E9%94%8B-%E9%9D%9E%E8%B5%B0%E4%B8%8D%E5%8F%AF.flac&metadata=false Jun 06 23:57:37 volumio-3b volumio[5317]: info: URI /mnt/INTERNAL/Music/谢霆锋-非走不可.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Exploding uri music-library/INTERNAL/Music/谢霆锋-活着Viva.flac in service mpd Jun 06 23:57:37 volumio-3b volumio[5317]: info: ALBUMART /albumart?cacheid=499&web=%E8%B0%A2%E9%9C%86%E9%94%8B/VIVA/mega&path=%2Fmnt%2FINTERNAL%2FMusic%2F%E8%B0%A2%E9%9C%86%E9%94%8B-%E6%B4%BB%E7%9D%80Viva.flac&metadata=false Jun 06 23:57:37 volumio-3b volumio[5317]: info: URI /mnt/INTERNAL/Music/谢霆锋-活着Viva.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Exploding uri music-library/INTERNAL/Music/林子祥-似梦迷离-《一咬O.K.》电影主题曲.flac in service mpd Jun 06 23:57:37 volumio-3b volumio[5317]: info: ALBUMART /albumart?cacheid=499&web=%E6%9E%97%E5%AD%90%E7%A5%A5/%E4%B8%96%E7%BA%AA%E5%A5%BD%E6%AD%8C/mega&path=%2Fmnt%2FINTERNAL%2FMusic%2F%E6%9E%97%E5%AD%90%E7%A5%A5-%E4%BC%BC%E6%A2%A6%E8%BF%B7%E7%A6%BB-%E3%80%8A%E4%B8%80%E5%92%ACO.K.%E3%80%8B%E7%94%B5%E5%BD%B1%E4%B8%BB%E9%A2%98%E6%9B%B2.flac&metadata=false Jun 06 23:57:37 volumio-3b volumio[5317]: info: URI /mnt/INTERNAL/Music/林子祥-似梦迷离-《一咬O.K.》电影主题曲.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Exploding uri music-library/INTERNAL/Music/张学友-旧情绵绵.flac in service mpd Jun 06 23:57:37 volumio-3b volumio[5317]: info: ALBUMART /albumart?cacheid=499&web=%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E4%BC%A0%E5%A5%87%20-%20%E6%88%91%E4%B8%8E%E4%BD%A0/mega&path=%2Fmnt%2FINTERNAL%2FMusic%2F%E5%BC%A0%E5%AD%A6%E5%8F%8B-%E6%97%A7%E6%83%85%E7%BB%B5%E7%BB%B5.flac&metadata=false Jun 06 23:57:37 volumio-3b volumio[5317]: info: URI /mnt/INTERNAL/Music/张学友-旧情绵绵.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Exploding uri music-library/INTERNAL/Music/谢霆锋-早知.flac in service mpd Jun 06 23:57:37 volumio-3b volumio[5317]: info: ALBUMART /albumart?cacheid=499&web=%E8%B0%A2%E9%9C%86%E9%94%8B/%E5%B1%95%E8%A7%88/mega&path=%2Fmnt%2FINTERNAL%2FMusic%2F%E8%B0%A2%E9%9C%86%E9%94%8B-%E6%97%A9%E7%9F%A5.flac&metadata=false Jun 06 23:57:37 volumio-3b volumio[5317]: info: URI /mnt/INTERNAL/Music/谢霆锋-早知.flac Jun 06 23:57:37 volumio-3b volumio[5317]: info: Exploding uri music-library/INTERNAL/Music/谢霆锋-一击即中.flac in service mpd Jun 06 23:57:37 volumio-3b volumio[5317]: info: ALBUMART /albumart?cacheid=499&web=%E8%B0%A2%E9%9C%86%E9%94%8B/%E9%9B%B6%E8%B7%9D%E7%A6%BB/mega&path=%2Fmnt%2FINTERNAL%2FMusic%2F%E8%B0%A2%E9%9C%86%E9%94%8B-%E4%B8%80%E5%87%BB%E5%8D%B3%E4%B8%AD.flac&metadata=false Jun 06 23:57:37 volumio-3b volumio[5317]: info: URI /mnt/INTERNAL/Music/谢霆锋-一击即中.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Preload queue cleared Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::ClearQueue Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::stPlaybackTimer Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::updateTrackBlock Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrackBlock Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::serviceStop Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::serviceStop Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::stop Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::clearPlayQueue Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::saveQueue Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushQueue Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::addQueueItems Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::addQueueItems Jun 06 23:57:38 volumio-3b volumio[5317]: info: Preload queue cleared Jun 06 23:57:38 volumio-3b volumio[5317]: info: Adding Item to queue: music-library/INTERNAL/Music/谢霆锋-非走不可.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Using cached record of: music-library/INTERNAL/Music/谢霆锋-非走不可.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushQueue Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::saveQueue Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::updateTrackBlock Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrackBlock Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPlay Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::play index 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::addQueueItems Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::addQueueItems Jun 06 23:57:38 volumio-3b volumio[5317]: info: Preload queue cleared Jun 06 23:57:38 volumio-3b volumio[5317]: info: Adding Item to queue: music-library/INTERNAL/Music/谢霆锋-活着Viva.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Using cached record of: music-library/INTERNAL/Music/谢霆锋-活着Viva.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Adding Item to queue: music-library/INTERNAL/Music/林子祥-似梦迷离-《一咬O.K.》电影主题曲.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Using cached record of: music-library/INTERNAL/Music/林子祥-似梦迷离-《一咬O.K.》电影主题曲.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Adding Item to queue: music-library/INTERNAL/Music/张学友-旧情绵绵.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Using cached record of: music-library/INTERNAL/Music/张学友-旧情绵绵.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Adding Item to queue: music-library/INTERNAL/Music/谢霆锋-早知.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Using cached record of: music-library/INTERNAL/Music/谢霆锋-早知.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Adding Item to queue: music-library/INTERNAL/Music/谢霆锋-一击即中.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: Using cached record of: music-library/INTERNAL/Music/谢霆锋-一击即中.flac Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushQueue Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::saveQueue Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::play index undefined Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::updateTrackBlock Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrackBlock Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::startPlaybackTimer Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Music/谢霆锋-非走不可.flac Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand stop took 81 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand stop took 12 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand clear Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 11 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand clear took 11 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 10 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 8 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Music/谢霆锋-非走不可.flac" Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: No code Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: No code Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 95ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 98ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:38 volumio-3b volumio[5317]: error: updateQueue error: null Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 139ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 135 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand add "INTERNAL/Music/谢霆锋-非走不可.flac" took 135 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 47ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 44ms Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand play Jun 06 23:57:38 volumio-3b volumio[5317]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 158ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces system playlist update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Ignoring MPD Status Update Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 50ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand play took 42 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 39ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 38ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: touch_display: Setting screensaver timeout to 120 seconds. Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 17 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 14 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 12 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: Jun 06 23:57:38 volumio-3b volumio[5317]: ---------------------------- MPD announces state update: player Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::getState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand status Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 28 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 25 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 24 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 24 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 20 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand status took 17 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseState Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"611 Kbps","isStreaming":false,"title":"非走不可","artist":"谢霆锋","album":"Believe","uri":"INTERNAL/Music/谢霆锋-非走不可.flac","trackType":"flac"} Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus stop Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"611 Kbps","isStreaming":false,"title":"非走不可","artist":"谢霆锋","album":"Believe","uri":"INTERNAL/Music/谢霆锋-非走不可.flac","trackType":"flac"} Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:38 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"611 Kbps","isStreaming":false,"title":"非走不可","artist":"谢霆锋","album":"Believe","uri":"INTERNAL/Music/谢霆锋-非走不可.flac","trackType":"flac"} Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:38 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 92ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 122ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: ------------------------------ 121ms Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 78 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 75 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: info: sendMpdCommand playlistinfo took 75 milliseconds Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: ControllerMpd::parseTrackInfo Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"611 Kbps","isStreaming":false,"title":"非走不可","artist":"谢霆锋","album":"Believe","uri":"INTERNAL/Music/谢霆锋-非走不可.flac","trackType":"flac"} Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:38 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"611 Kbps","isStreaming":false,"title":"非走不可","artist":"谢霆锋","album":"Believe","uri":"INTERNAL/Music/谢霆锋-非走不可.flac","trackType":"flac"} Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:38 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: ControllerMpd::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreCommandRouter::servicePushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"611 Kbps","isStreaming":false,"title":"非走不可","artist":"谢霆锋","album":"Believe","uri":"INTERNAL/Music/谢霆锋-非走不可.flac","trackType":"flac"} Jun 06 23:57:38 volumio-3b volumio[5317]: verbose: CURRENT POSITION 0 Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState stateService play Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::syncState currentStatus play Jun 06 23:57:38 volumio-3b volumio[5317]: info: Received an update from plugin. extracting info from payload Jun 06 23:57:38 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:38 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:39 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:39 volumio-3b volumio[5317]: info: CoreStateMachine::pushState Jun 06 23:57:39 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:57:39 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioPushState Jun 06 23:57:39 volumio-3b volumio[5317]: info: ------------------------------ 231ms Jun 06 23:57:39 volumio-3b volumio[5317]: info: ------------------------------ 220ms Jun 06 23:57:39 volumio-3b volumio[5317]: info: ------------------------------ 219ms Jun 06 23:57:39 volumio-3b volumio[5317]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 06 23:57:48 volumio-3b volumio[5317]: info: CoreCommandRouter::volumioGetState Jun 06 23:57:48 volumio-3b volumio[5317]: info: CorePlayQueue::getTrack 0 Jun 06 23:58:59 volumio-3b volumio[5317]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 06 23:58:59 volumio-3b volumio[5317]: Error: connect ETIMEDOUT 162.125.34.133:443 Jun 06 23:58:59 volumio-3b volumio[5317]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jun 06 23:58:59 volumio-3b volumio[5317]: errno: -110, Jun 06 23:58:59 volumio-3b volumio[5317]: code: 'ETIMEDOUT', Jun 06 23:58:59 volumio-3b volumio[5317]: syscall: 'connect', Jun 06 23:58:59 volumio-3b volumio[5317]: address: '162.125.34.133', Jun 06 23:58:59 volumio-3b volumio[5317]: port: 443 Jun 06 23:58:59 volumio-3b volumio[5317]: } Jun 06 23:58:59 volumio-3b volumio[5317]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 06 23:58:59 volumio-3b sudo[6907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-06 23:57 Jun 06 23:58:59 volumio-3b sudo[6907]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"