-- Logs begin at Sat 2025-06-28 15:33:34 HKT, end at Sat 2025-06-28 16:05:16 HKT. -- Jun 28 16:04:33 volumio volumio[1260]: info: Clearing queue after UPNP request Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::ClearQueue Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::stop Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::stPlaybackTimer Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::updateTrackBlock Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrackBlock Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::serviceStop Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: ControllerMpd::stop Jun 28 16:04:33 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::clearPlayQueue Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::saveQueue Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Jun 28 16:04:33 volumio volumio[1260]: info: Jun 28 16:04:33 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:33 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:33 volumio volumio[1260]: info: Jun 28 16:04:33 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:33 volumio volumio[1260]: info: sendMpdCommand stop took 15 milliseconds Jun 28 16:04:33 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:33 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:33 volumio volumio[1260]: info: Jun 28 16:04:33 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:33 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:33 volumio volumio[1260]: info: Jun 28 16:04:33 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:33 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:33 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:33 volumio volumio[1260]: info: Jun 28 16:04:33 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:33 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:33 volumio volumio[1260]: info: Jun 28 16:04:33 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:33 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:33 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:33 volumio volumio[1260]: error: updateQueue error: null Jun 28 16:04:33 volumio volumio[1260]: error: updateQueue error: null Jun 28 16:04:33 volumio volumio[1260]: error: updateQueue error: null Jun 28 16:04:33 volumio volumio[1260]: info: ------------------------------ 4ms Jun 28 16:04:33 volumio volumio[1260]: info: sendMpdCommand status took 3 milliseconds Jun 28 16:04:33 volumio volumio[1260]: info: ------------------------------ 4ms Jun 28 16:04:33 volumio volumio[1260]: info: sendMpdCommand status took 3 milliseconds Jun 28 16:04:33 volumio volumio[1260]: info: ------------------------------ 3ms Jun 28 16:04:33 volumio volumio[1260]: info: sendMpdCommand status took 2 milliseconds Jun 28 16:04:33 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:33 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:33 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:33 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: 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 28 16:04:33 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::syncState stateService stop Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: No code Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: 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 28 16:04:33 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::syncState stateService stop Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: No code Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: 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 28 16:04:33 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::syncState stateService stop Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: No code Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:33 volumio volumio[1260]: info: ------------------------------ 53ms Jun 28 16:04:33 volumio volumio[1260]: info: ------------------------------ 51ms Jun 28 16:04:33 volumio volumio[1260]: info: Starting UPNP Playback Jun 28 16:04:33 volumio volumio[1260]: info: Preparing playback through UPNP Jun 28 16:04:33 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Jun 28 16:04:33 volumio volumio[1260]: info: CorePlayQueue::getTrack 12 Jun 28 16:04:33 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 2ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 2ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 2ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 2ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 2ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 2ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Jun 28 16:04:34 volumio volumio[1260]: info: Ignoring MPD Status Update Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 1ms Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand status took 11 milliseconds Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand status took 11 milliseconds Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand status took 10 milliseconds Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:34 volumio volumio[1260]: verbose: In UPNP mode Jun 28 16:04:34 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"way down deep","artist":"Jennifer Warnes (Performer)","album":null,"uri":"http://rc.sycdn.kuwo.cn/ba6b341fc7c3af808d054c4301e10f18/685fa211/resource/n2/48/52/4161713076.mp3","trackType":"mp3"} Jun 28 16:04:34 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 14ms Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:34 volumio volumio[1260]: info: Jun 28 16:04:34 volumio volumio[1260]: ---------------------------- MPD announces state update: player Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::getState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand status took 4 milliseconds Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand status took 2 milliseconds Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand status took 1 milliseconds Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseState Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:34 volumio volumio[1260]: verbose: In UPNP mode Jun 28 16:04:34 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"way down deep","artist":"Jennifer Warnes (Performer)","album":null,"uri":"http://rc.sycdn.kuwo.cn/ba6b341fc7c3af808d054c4301e10f18/685fa211/resource/n2/48/52/4161713076.mp3","trackType":"mp3"} Jun 28 16:04:34 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Jun 28 16:04:34 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:34 volumio volumio[1260]: verbose: In UPNP mode Jun 28 16:04:34 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"way down deep","artist":"Jennifer Warnes (Performer)","album":null,"uri":"http://rc.sycdn.kuwo.cn/ba6b341fc7c3af808d054c4301e10f18/685fa211/resource/n2/48/52/4161713076.mp3","trackType":"mp3"} Jun 28 16:04:34 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Jun 28 16:04:34 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 38ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 37ms Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 23 milliseconds Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 23 milliseconds Jun 28 16:04:34 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 21 milliseconds Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Jun 28 16:04:34 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:34 volumio volumio[1260]: verbose: In UPNP mode Jun 28 16:04:34 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"way down deep","artist":"Jennifer Warnes (Performer)","album":null,"uri":"http://rc.sycdn.kuwo.cn/ba6b341fc7c3af808d054c4301e10f18/685fa211/resource/n2/48/52/4161713076.mp3","trackType":"mp3"} Jun 28 16:04:34 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Jun 28 16:04:34 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:34 volumio volumio[1260]: verbose: In UPNP mode Jun 28 16:04:34 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"way down deep","artist":"Jennifer Warnes (Performer)","album":null,"uri":"http://rc.sycdn.kuwo.cn/ba6b341fc7c3af808d054c4301e10f18/685fa211/resource/n2/48/52/4161713076.mp3","trackType":"mp3"} Jun 28 16:04:34 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Jun 28 16:04:34 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: ControllerMpd::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Jun 28 16:04:34 volumio volumio[1260]: verbose: In UPNP mode Jun 28 16:04:34 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"way down deep","artist":"Jennifer Warnes (Performer)","album":null,"uri":"http://rc.sycdn.kuwo.cn/ba6b341fc7c3af808d054c4301e10f18/685fa211/resource/n2/48/52/4161713076.mp3","trackType":"mp3"} Jun 28 16:04:34 volumio volumio[1260]: verbose: CURRENT POSITION 12 Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Jun 28 16:04:34 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreStateMachine::pushState Jun 28 16:04:34 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 62ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 60ms Jun 28 16:04:34 volumio volumio[1260]: info: ------------------------------ 60ms Jun 28 16:05:15 volumio volumio[1260]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 16:05:15 volumio volumio[1260]: Error: connect ETIMEDOUT 108.160.169.55:443 Jun 28 16:05:15 volumio volumio[1260]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 28 16:05:15 volumio volumio[1260]: errno: -110, Jun 28 16:05:15 volumio volumio[1260]: code: 'ETIMEDOUT', Jun 28 16:05:15 volumio volumio[1260]: syscall: 'connect', Jun 28 16:05:15 volumio volumio[1260]: address: '108.160.169.55', Jun 28 16:05:15 volumio volumio[1260]: port: 443 Jun 28 16:05:15 volumio volumio[1260]: } Jun 28 16:05:15 volumio volumio[1260]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 16:05:16 volumio sudo[10179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-28 16:04 Jun 28 16:05:16 volumio sudo[10179]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 12:21:23 PM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a9588e47e4b05f1a05bf70b4acc7555c"