-- Logs begin at Tue 2024-10-08 11:56:24 UTC, end at Tue 2024-10-08 12:03:39 UTC. -- Oct 08 12:02:06 volumio volumio[934]: info: Clearing queue after UPNP request Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::ClearQueue Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::stop Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::stPlaybackTimer Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::updateTrackBlock Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrackBlock Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::serviceStop Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: ControllerMpd::stop Oct 08 12:02:07 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand stop Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::clearPlayQueue Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::saveQueue Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushQueue Oct 08 12:02:07 volumio volumio[934]: info: sendMpdCommand stop took 81 milliseconds Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:07 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:07 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:07 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:07 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: sendMpdCommand status took 5 milliseconds Oct 08 12:02:07 volumio volumio[934]: info: sendMpdCommand status took 4 milliseconds Oct 08 12:02:07 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:07 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:07 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: 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} Oct 08 12:02:07 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:07 volumio volumio[934]: info: No code Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:07 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: 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} Oct 08 12:02:07 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:07 volumio volumio[934]: info: No code Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 107ms Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 105ms Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:07 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 108ms Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 5ms Oct 08 12:02:07 volumio volumio[934]: info: Starting UPNP Playback Oct 08 12:02:07 volumio volumio[934]: info: Preparing playback through UPNP Oct 08 12:02:07 volumio volumio[934]: info: CoreCommandRouter::volumioGetState Oct 08 12:02:07 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:07 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: Oct 08 12:02:07 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:07 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:07 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:08 volumio volumio[934]: info: Oct 08 12:02:08 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:08 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:08 volumio volumio[934]: info: Oct 08 12:02:08 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:08 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:08 volumio volumio[934]: info: sendMpdCommand status took 36 milliseconds Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:08 volumio volumio[934]: info: Oct 08 12:02:08 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:08 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:08 volumio volumio[934]: info: sendMpdCommand status took 22 milliseconds Oct 08 12:02:08 volumio volumio[934]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:08 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:08 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:08 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":709,"samplerate":"16 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如果可以","artist":"杜宣达","album":"如果可以","uri":"http://m801.music.126.net/20241008202706/abd0de6372dafe7a7c3e4b3cee6c453f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35121148192/437a/e265/4c9f/cfb7a3f0009956c48a56e050d9c83106.m4a","trackType":"m4a"} Oct 08 12:02:08 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:08 volumio volumio[934]: info: ------------------------------ 76ms Oct 08 12:02:08 volumio volumio[934]: info: Oct 08 12:02:08 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:08 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:08 volumio volumio[934]: info: sendMpdCommand status took 32 milliseconds Oct 08 12:02:08 volumio volumio[934]: info: sendMpdCommand playlistinfo took 22 milliseconds Oct 08 12:02:08 volumio volumio[934]: info: sendMpdCommand status took 4 milliseconds Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:08 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:08 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:08 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":709,"samplerate":"16 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如果可以","artist":"杜宣达","album":"如果可以","uri":"http://m801.music.126.net/20241008202706/abd0de6372dafe7a7c3e4b3cee6c453f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35121148192/437a/e265/4c9f/cfb7a3f0009956c48a56e050d9c83106.m4a","trackType":"m4a"} Oct 08 12:02:08 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:08 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:08 volumio volumio[934]: info: ------------------------------ 129ms Oct 08 12:02:08 volumio volumio[934]: info: sendMpdCommand playlistinfo took 49 milliseconds Oct 08 12:02:08 volumio volumio[934]: info: sendMpdCommand playlistinfo took 49 milliseconds Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:08 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:08 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:08 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:08 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":709,"samplerate":"16 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如果可以","artist":"杜宣达","album":"如果可以","uri":"http://m801.music.126.net/20241008202706/abd0de6372dafe7a7c3e4b3cee6c453f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35121148192/437a/e265/4c9f/cfb7a3f0009956c48a56e050d9c83106.m4a","trackType":"m4a"} Oct 08 12:02:08 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:08 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:08 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:08 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:08 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":709,"samplerate":"16 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如果可以","artist":"杜宣达","album":"如果可以","uri":"http://m801.music.126.net/20241008202706/abd0de6372dafe7a7c3e4b3cee6c453f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35121148192/437a/e265/4c9f/cfb7a3f0009956c48a56e050d9c83106.m4a","trackType":"m4a"} Oct 08 12:02:08 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:08 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:08 volumio volumio[934]: info: ------------------------------ 208ms Oct 08 12:02:08 volumio volumio[934]: info: ------------------------------ 179ms Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:08 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:08 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:09 volumio ntpd[924]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 08 12:02:09 volumio volumio[934]: info: Oct 08 12:02:09 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:09 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:09 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:09 volumio volumio[934]: info: Oct 08 12:02:09 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:09 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:09 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:09 volumio volumio[934]: info: sendMpdCommand status took 4 milliseconds Oct 08 12:02:09 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:09 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:09 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:09 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:09 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:09 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:09 volumio volumio[934]: 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} Oct 08 12:02:09 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:09 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:09 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:09 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:09 volumio volumio[934]: info: CoreStateMachine::stPlaybackTimer Oct 08 12:02:09 volumio volumio[934]: info: ------------------------------ 36ms Oct 08 12:02:09 volumio volumio[934]: info: sendMpdCommand status took 35 milliseconds Oct 08 12:02:09 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:09 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:09 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:09 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:09 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 12:02:09 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:10 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:10 volumio volumio[934]: 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} Oct 08 12:02:10 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:10 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:10 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:10 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:10 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:10 volumio volumio[934]: info: No code Oct 08 12:02:10 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:10 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:10 volumio volumio[934]: info: ------------------------------ 90ms Oct 08 12:02:10 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:10 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:10 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:10 volumio kernel: perf: interrupt took too long (2515 > 2500), lowering kernel.perf_event_max_sample_rate to 79500 Oct 08 12:02:15 volumio volumio[934]: info: Clearing queue after UPNP request Oct 08 12:02:15 volumio volumio[934]: info: CoreStateMachine::ClearQueue Oct 08 12:02:15 volumio volumio[934]: info: CoreStateMachine::stop Oct 08 12:02:15 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 12:02:15 volumio volumio[934]: info: CorePlayQueue::clearPlayQueue Oct 08 12:02:15 volumio volumio[934]: info: CorePlayQueue::saveQueue Oct 08 12:02:15 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:15 volumio volumio[934]: info: CoreCommandRouter::volumioPushQueue Oct 08 12:02:15 volumio volumio[934]: info: Oct 08 12:02:15 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:15 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:15 volumio volumio[934]: info: Oct 08 12:02:15 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:15 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:15 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:15 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:15 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:15 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:15 volumio volumio[934]: info: Starting UPNP Playback Oct 08 12:02:15 volumio volumio[934]: info: Preparing playback through UPNP Oct 08 12:02:15 volumio volumio[934]: info: CoreCommandRouter::volumioGetState Oct 08 12:02:15 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:15 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 5ms Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 5ms Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 6ms Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:16 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:16 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:16 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:16 volumio volumio[934]: info: sendMpdCommand status took 39 milliseconds Oct 08 12:02:16 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:16 volumio volumio[934]: info: sendMpdCommand status took 41 milliseconds Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:16 volumio volumio[934]: info: Oct 08 12:02:16 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:16 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:16 volumio volumio[934]: info: sendMpdCommand status took 10 milliseconds Oct 08 12:02:16 volumio volumio[934]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 08 12:02:16 volumio volumio[934]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 08 12:02:16 volumio volumio[934]: info: sendMpdCommand status took 4 milliseconds Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:16 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:16 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:16 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"散歩","artist":"Canappeco","album":"oto note","uri":"http://m801.music.126.net/20241008202715/315f3e26c4365d22b875654a12149ad5/jdyyaac/565d/5308/030f/a7f101ba1ddbaa2245134e864104e9d0.m4a","trackType":"m4a"} Oct 08 12:02:16 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:16 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:16 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:16 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":243,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"散歩","artist":"Canappeco","album":"oto note","uri":"http://m801.music.126.net/20241008202715/315f3e26c4365d22b875654a12149ad5/jdyyaac/565d/5308/030f/a7f101ba1ddbaa2245134e864104e9d0.m4a","trackType":"m4a"} Oct 08 12:02:16 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:16 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 80ms Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 92ms Oct 08 12:02:16 volumio volumio[934]: info: sendMpdCommand playlistinfo took 41 milliseconds Oct 08 12:02:16 volumio volumio[934]: info: sendMpdCommand playlistinfo took 40 milliseconds Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:16 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:16 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:16 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:16 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":243,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"散歩","artist":"Canappeco","album":"oto note","uri":"http://m801.music.126.net/20241008202715/315f3e26c4365d22b875654a12149ad5/jdyyaac/565d/5308/030f/a7f101ba1ddbaa2245134e864104e9d0.m4a","trackType":"m4a"} Oct 08 12:02:16 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:16 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:16 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:16 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:16 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":243,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"散歩","artist":"Canappeco","album":"oto note","uri":"http://m801.music.126.net/20241008202715/315f3e26c4365d22b875654a12149ad5/jdyyaac/565d/5308/030f/a7f101ba1ddbaa2245134e864104e9d0.m4a","trackType":"m4a"} Oct 08 12:02:16 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:16 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 124ms Oct 08 12:02:16 volumio volumio[934]: info: ------------------------------ 117ms Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:16 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:16 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:20 volumio volumio[934]: info: Clearing queue after UPNP request Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::ClearQueue Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::stop Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::stPlaybackTimer Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::updateTrackBlock Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrackBlock Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::serviceStop Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: ControllerMpd::stop Oct 08 12:02:20 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand stop Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::clearPlayQueue Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::saveQueue Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushQueue Oct 08 12:02:20 volumio volumio[934]: info: sendMpdCommand stop took 39 milliseconds Oct 08 12:02:20 volumio volumio[934]: info: Oct 08 12:02:20 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:20 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:20 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:20 volumio volumio[934]: info: Oct 08 12:02:20 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:20 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:20 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:20 volumio volumio[934]: info: Oct 08 12:02:20 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:20 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:20 volumio volumio[934]: info: sendMpdCommand status took 5 milliseconds Oct 08 12:02:20 volumio volumio[934]: info: sendMpdCommand status took 3 milliseconds Oct 08 12:02:20 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:20 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:20 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: 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} Oct 08 12:02:20 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:20 volumio volumio[934]: info: No code Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:20 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: 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} Oct 08 12:02:20 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:20 volumio volumio[934]: info: No code Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:20 volumio volumio[934]: info: ------------------------------ 91ms Oct 08 12:02:20 volumio volumio[934]: info: ------------------------------ 91ms Oct 08 12:02:20 volumio volumio[934]: info: Oct 08 12:02:20 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:20 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:20 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:20 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:20 volumio volumio[934]: info: ------------------------------ 126ms Oct 08 12:02:20 volumio volumio[934]: info: ------------------------------ 17ms Oct 08 12:02:20 volumio volumio[934]: info: Starting UPNP Playback Oct 08 12:02:20 volumio volumio[934]: info: Preparing playback through UPNP Oct 08 12:02:20 volumio volumio[934]: info: CoreCommandRouter::volumioGetState Oct 08 12:02:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:20 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:21 volumio volumio[934]: info: Oct 08 12:02:21 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:21 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:21 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:22 volumio volumio[934]: info: Oct 08 12:02:22 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:22 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:22 volumio volumio[934]: info: Oct 08 12:02:22 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:22 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 08 12:02:22 volumio volumio[934]: info: sendMpdCommand status took 9 milliseconds Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 08 12:02:22 volumio volumio[934]: info: sendMpdCommand status took 9 milliseconds Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:22 volumio volumio[934]: info: sendMpdCommand clearerror took 9 milliseconds Oct 08 12:02:22 volumio volumio[934]: info: sendMpdCommand clearerror took 8 milliseconds Oct 08 12:02:22 volumio volumio[934]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 08 12:02:22 volumio volumio[934]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:22 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:22 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:22 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:22 volumio volumio[934]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如果可以","artist":"杜宣达","album":"如果可以","uri":"http://m701.music.126.net/20241008202720/c10f199ecd381ed45bc17985d5af58ba/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35121148192/437a/e265/4c9f/cfb7a3f0009956c48a56e050d9c83106.m4a","trackType":"m4a"} Oct 08 12:02:22 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:22 volumio volumio[934]: info: No code Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:22 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:22 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:22 volumio volumio[934]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如果可以","artist":"杜宣达","album":"如果可以","uri":"http://m701.music.126.net/20241008202720/c10f199ecd381ed45bc17985d5af58ba/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35121148192/437a/e265/4c9f/cfb7a3f0009956c48a56e050d9c83106.m4a","trackType":"m4a"} Oct 08 12:02:22 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:22 volumio volumio[934]: info: No code Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:22 volumio volumio[934]: info: ------------------------------ 92ms Oct 08 12:02:22 volumio volumio[934]: info: ------------------------------ 92ms Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:22 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:22 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:26 volumio volumio[934]: info: Clearing queue after UPNP request Oct 08 12:02:26 volumio volumio[934]: info: CoreStateMachine::ClearQueue Oct 08 12:02:26 volumio volumio[934]: info: CoreStateMachine::stop Oct 08 12:02:26 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 12:02:26 volumio volumio[934]: info: CorePlayQueue::clearPlayQueue Oct 08 12:02:26 volumio volumio[934]: info: CorePlayQueue::saveQueue Oct 08 12:02:26 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:26 volumio volumio[934]: info: CoreCommandRouter::volumioPushQueue Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:27 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 5ms Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:27 volumio volumio[934]: info: Starting UPNP Playback Oct 08 12:02:27 volumio volumio[934]: info: Preparing playback through UPNP Oct 08 12:02:27 volumio volumio[934]: info: CoreCommandRouter::volumioGetState Oct 08 12:02:27 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:27 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 5ms Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 5ms Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: Oct 08 12:02:27 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:27 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:27 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:28 volumio volumio[934]: info: Oct 08 12:02:28 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:28 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:28 volumio volumio[934]: info: Oct 08 12:02:28 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:28 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 08 12:02:28 volumio volumio[934]: info: sendMpdCommand status took 9 milliseconds Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 08 12:02:28 volumio volumio[934]: info: sendMpdCommand status took 22 milliseconds Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:28 volumio volumio[934]: info: sendMpdCommand clearerror took 24 milliseconds Oct 08 12:02:28 volumio volumio[934]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 08 12:02:28 volumio volumio[934]: info: sendMpdCommand clearerror took 10 milliseconds Oct 08 12:02:28 volumio volumio[934]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:28 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:28 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:28 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:28 volumio volumio[934]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如果可以","artist":"杜宣达","album":"如果可以","uri":"http://m701.music.126.net/20241008202726/4c21252d2b8c40260ccf42e3e2dbeecf/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35121148192/437a/e265/4c9f/cfb7a3f0009956c48a56e050d9c83106.m4a","trackType":"m4a"} Oct 08 12:02:28 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:28 volumio volumio[934]: info: No code Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:28 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:28 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:28 volumio volumio[934]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如果可以","artist":"杜宣达","album":"如果可以","uri":"http://m701.music.126.net/20241008202726/4c21252d2b8c40260ccf42e3e2dbeecf/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35121148192/437a/e265/4c9f/cfb7a3f0009956c48a56e050d9c83106.m4a","trackType":"m4a"} Oct 08 12:02:28 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:28 volumio volumio[934]: info: No code Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:28 volumio volumio[934]: info: ------------------------------ 136ms Oct 08 12:02:28 volumio volumio[934]: info: ------------------------------ 134ms Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:28 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:28 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:31 volumio volumio[934]: info: Clearing queue after UPNP request Oct 08 12:02:31 volumio volumio[934]: info: CoreStateMachine::ClearQueue Oct 08 12:02:31 volumio volumio[934]: info: CoreStateMachine::stop Oct 08 12:02:31 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 12:02:31 volumio volumio[934]: info: CorePlayQueue::clearPlayQueue Oct 08 12:02:31 volumio volumio[934]: info: CorePlayQueue::saveQueue Oct 08 12:02:31 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:31 volumio volumio[934]: info: CoreCommandRouter::volumioPushQueue Oct 08 12:02:31 volumio volumio[934]: info: Oct 08 12:02:31 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:31 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:31 volumio volumio[934]: info: Oct 08 12:02:31 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:31 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:31 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:31 volumio volumio[934]: error: updateQueue error: null Oct 08 12:02:31 volumio volumio[934]: info: ------------------------------ 6ms Oct 08 12:02:31 volumio volumio[934]: info: ------------------------------ 5ms Oct 08 12:02:31 volumio volumio[934]: info: Starting UPNP Playback Oct 08 12:02:31 volumio volumio[934]: info: Preparing playback through UPNP Oct 08 12:02:31 volumio volumio[934]: info: CoreCommandRouter::volumioGetState Oct 08 12:02:31 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:02:31 volumio volumio[934]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 6ms Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 4ms Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 3ms Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces system playlist update Oct 08 12:02:32 volumio volumio[934]: info: Ignoring MPD Status Update Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 2ms Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:32 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:32 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:32 volumio volumio[934]: info: sendMpdCommand status took 41 milliseconds Oct 08 12:02:32 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:32 volumio volumio[934]: info: sendMpdCommand status took 42 milliseconds Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:32 volumio volumio[934]: info: Oct 08 12:02:32 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:02:32 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:02:32 volumio volumio[934]: info: sendMpdCommand status took 6 milliseconds Oct 08 12:02:32 volumio volumio[934]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 08 12:02:32 volumio volumio[934]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 08 12:02:32 volumio volumio[934]: info: sendMpdCommand status took 3 milliseconds Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 12:02:32 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:32 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:32 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":47,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"在加纳共和国离婚 (Live版)","artist":"杨坤/张碧晨","album":"天赐的声音第五季 第3期","uri":"http://m702.music.126.net/20241008202731/b72205b735c282f60a4da762cf055948/jd-musicrep-ts/56fb/bb6b/5476/ce694ad87a41fdf890a65592c1b54531.mp3","trackType":"mp3"} Oct 08 12:02:32 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:02:32 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:32 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:32 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31,"duration":47,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"在加纳共和国离婚 (Live版)","artist":"杨坤/张碧晨","album":"天赐的声音第五季 第3期","uri":"http://m702.music.126.net/20241008202731/b72205b735c282f60a4da762cf055948/jd-musicrep-ts/56fb/bb6b/5476/ce694ad87a41fdf890a65592c1b54531.mp3","trackType":"mp3"} Oct 08 12:02:32 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:32 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 82ms Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 111ms Oct 08 12:02:32 volumio volumio[934]: info: sendMpdCommand playlistinfo took 61 milliseconds Oct 08 12:02:32 volumio volumio[934]: info: sendMpdCommand playlistinfo took 60 milliseconds Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:32 volumio volumio[934]: verbose: ControllerMpd::parseTrackInfo Oct 08 12:02:32 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:32 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:32 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":47,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"在加纳共和国离婚 (Live版)","artist":"杨坤/张碧晨","album":"天赐的声音第五季 第3期","uri":"http://m702.music.126.net/20241008202731/b72205b735c282f60a4da762cf055948/jd-musicrep-ts/56fb/bb6b/5476/ce694ad87a41fdf890a65592c1b54531.mp3","trackType":"mp3"} Oct 08 12:02:32 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:32 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:32 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:02:32 volumio volumio[934]: verbose: In UPNP mode Oct 08 12:02:32 volumio volumio[934]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":47,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"在加纳共和国离婚 (Live版)","artist":"杨坤/张碧晨","album":"天赐的声音第五季 第3期","uri":"http://m702.music.126.net/20241008202731/b72205b735c282f60a4da762cf055948/jd-musicrep-ts/56fb/bb6b/5476/ce694ad87a41fdf890a65592c1b54531.mp3","trackType":"mp3"} Oct 08 12:02:32 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::syncState stateService play Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:02:32 volumio volumio[934]: info: Received an update from plugin. extracting info from payload Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 172ms Oct 08 12:02:32 volumio volumio[934]: info: ------------------------------ 168ms Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:02:32 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:02:32 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:03:20 volumio volumio[934]: info: Oct 08 12:03:20 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:03:20 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:03:20 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:03:20 volumio volumio[934]: info: Oct 08 12:03:20 volumio volumio[934]: ---------------------------- MPD announces state update: player Oct 08 12:03:20 volumio volumio[934]: info: ControllerMpd::getState Oct 08 12:03:20 volumio volumio[934]: verbose: ControllerMpd::sendMpdCommand status Oct 08 12:03:20 volumio volumio[934]: info: sendMpdCommand status took 4 milliseconds Oct 08 12:03:20 volumio volumio[934]: info: sendMpdCommand status took 2 milliseconds Oct 08 12:03:20 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:03:20 volumio volumio[934]: verbose: ControllerMpd::parseState Oct 08 12:03:20 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:03:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:03:20 volumio volumio[934]: 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} Oct 08 12:03:20 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus play Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::stPlaybackTimer Oct 08 12:03:20 volumio volumio[934]: info: ControllerMpd::pushState Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::servicePushState Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:03:20 volumio volumio[934]: info: CorePlayQueue::getTrack 0 Oct 08 12:03:20 volumio volumio[934]: 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} Oct 08 12:03:20 volumio volumio[934]: verbose: CURRENT POSITION 0 Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::syncState stateService stop Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::syncState currentStatus stop Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:03:20 volumio volumio[934]: info: No code Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::pushState Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::volumioPushState Oct 08 12:03:20 volumio volumio[934]: info: ------------------------------ 79ms Oct 08 12:03:20 volumio volumio[934]: info: ------------------------------ 79ms Oct 08 12:03:20 volumio volumio[934]: info: CoreCommandRouter::volumioGetQueue Oct 08 12:03:20 volumio volumio[934]: info: CoreStateMachine::getQueue Oct 08 12:03:20 volumio volumio[934]: info: CorePlayQueue::getQueue Oct 08 12:03:38 volumio volumio[934]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 08 12:03:38 volumio volumio[934]: Error: connect ETIMEDOUT 115.126.100.160:443 Oct 08 12:03:38 volumio volumio[934]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 08 12:03:38 volumio volumio[934]: errno: -110, Oct 08 12:03:38 volumio volumio[934]: code: 'ETIMEDOUT', Oct 08 12:03:38 volumio volumio[934]: syscall: 'connect', Oct 08 12:03:38 volumio volumio[934]: address: '115.126.100.160', Oct 08 12:03:38 volumio volumio[934]: port: 443 Oct 08 12:03:38 volumio volumio[934]: } Oct 08 12:03:38 volumio volumio[934]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 08 12:03:39 volumio sudo[2329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-08 12:02 Oct 08 12:03:39 volumio sudo[2329]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="1d63a568b7d5e4a317f16be7d0961cbb2d82e282" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="4f8978e0148ab5e1610548b80abf1b4b5e03ea0a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 07 Feb 2023 05:04:19 PM CET" VOLUMIO_VERSION="3.429" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4c8dcdad83349056095d42fbad08221f"