-- Logs begin at Sun 2025-03-09 14:06:08 UTC, end at Fri 2025-03-14 13:22:36 UTC. -- Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:09 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:09 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:09 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:09 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:09 volumio volumio[4339]: info: sendMpdCommand status took 4 milliseconds Mar 14 13:21:09 volumio volumio[4339]: info: sendMpdCommand status took 3 milliseconds Mar 14 13:21:09 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:09 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:09 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:09 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:09 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 14 13:21:09 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 14 13:21:09 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:09 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:09 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:09 volumio volumio[4339]: 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://m801.music.126.net/20250314214525/b16fce07a815c11cf18afdf9ffeef614/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/12480744008/b2a6/2405/b037/89ae5891cabc720862ff263adcb4dc43.m4a?vuutv=bKO0rz/caEWDuHkPEB3QTNS7IZr8uuJAoEsiSGrRq9WXzce2QMXYcRVACbRgHe3ILElDBwgRf8FwOJOVAiZ406HZiUqnr5GpEsdwARM2Taw=","trackType":""} Mar 14 13:21:09 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::play index undefined Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:09 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:09 volumio volumio[4339]: 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://m801.music.126.net/20250314214525/b16fce07a815c11cf18afdf9ffeef614/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/12480744008/b2a6/2405/b037/89ae5891cabc720862ff263adcb4dc43.m4a?vuutv=bKO0rz/caEWDuHkPEB3QTNS7IZr8uuJAoEsiSGrRq9WXzce2QMXYcRVACbRgHe3ILElDBwgRf8FwOJOVAiZ406HZiUqnr5GpEsdwARM2Taw=","trackType":""} Mar 14 13:21:09 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:09 volumio volumio[4339]: info: No code Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 52ms Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 53ms Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:09 volumio volumio[4339]: info: Clearing queue after UPNP request Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::ClearQueue Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::stop Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::clearPlayQueue Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::saveQueue Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioPushQueue Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:09 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:09 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:09 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:21:09 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 7ms Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 3ms Mar 14 13:21:09 volumio volumio[4339]: info: Starting UPNP Playback Mar 14 13:21:09 volumio volumio[4339]: info: Preparing playback through UPNP Mar 14 13:21:09 volumio volumio[4339]: info: CoreCommandRouter::volumioGetState Mar 14 13:21:09 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:09 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:09 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:09 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:09 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:09 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:09 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:09 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:09 volumio volumio[4339]: info: Mar 14 13:21:09 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:09 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:10 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:10 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:10 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:10 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:10 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:10 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:10 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:10 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:10 volumio volumio[4339]: info: sendMpdCommand status took 9 milliseconds Mar 14 13:21:10 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:10 volumio volumio[4339]: info: Mar 14 13:21:10 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:10 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:10 volumio volumio[4339]: info: sendMpdCommand status took 7 milliseconds Mar 14 13:21:10 volumio volumio[4339]: info: sendMpdCommand status took 3 milliseconds Mar 14 13:21:10 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 14 13:21:10 volumio volumio[4339]: info: sendMpdCommand status took 1 milliseconds Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:10 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:10 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:10 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":425,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲菲","album":"那些年","uri":"http://m701.music.126.net/20250314214609/b7a99e4d46926f1d2b8b46c7083d6e6c/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26943957257/52e8/389e/7906/21b1a30b9ab1cfc5c065169fa68ef8ee.m4a?vuutv=Sh+Q4GTlkj59WsYPVwFlPamNP8NR2+55W4zGLzytbtKmNmfnG/TdT9YLTFfblWEL+ZNUJYdZwTRfDy1A7YqDCdz3Taw+IN5MrR3uKVnxyPM=","trackType":""} Mar 14 13:21:10 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 28ms Mar 14 13:21:10 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 15 milliseconds Mar 14 13:21:10 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:10 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:10 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:10 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:10 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":425,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲菲","album":"那些年","uri":"http://m701.music.126.net/20250314214609/b7a99e4d46926f1d2b8b46c7083d6e6c/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26943957257/52e8/389e/7906/21b1a30b9ab1cfc5c065169fa68ef8ee.m4a?vuutv=Sh+Q4GTlkj59WsYPVwFlPamNP8NR2+55W4zGLzytbtKmNmfnG/TdT9YLTFfblWEL+ZNUJYdZwTRfDy1A7YqDCdz3Taw+IN5MrR3uKVnxyPM=","trackType":""} Mar 14 13:21:10 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:10 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:10 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:10 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:10 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":425,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲菲","album":"那些年","uri":"http://m701.music.126.net/20250314214609/b7a99e4d46926f1d2b8b46c7083d6e6c/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26943957257/52e8/389e/7906/21b1a30b9ab1cfc5c065169fa68ef8ee.m4a?vuutv=Sh+Q4GTlkj59WsYPVwFlPamNP8NR2+55W4zGLzytbtKmNmfnG/TdT9YLTFfblWEL+ZNUJYdZwTRfDy1A7YqDCdz3Taw+IN5MrR3uKVnxyPM=","trackType":""} Mar 14 13:21:10 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:10 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:10 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:10 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:10 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":425,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲菲","album":"那些年","uri":"http://m701.music.126.net/20250314214609/b7a99e4d46926f1d2b8b46c7083d6e6c/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26943957257/52e8/389e/7906/21b1a30b9ab1cfc5c065169fa68ef8ee.m4a?vuutv=Sh+Q4GTlkj59WsYPVwFlPamNP8NR2+55W4zGLzytbtKmNmfnG/TdT9YLTFfblWEL+ZNUJYdZwTRfDy1A7YqDCdz3Taw+IN5MrR3uKVnxyPM=","trackType":""} Mar 14 13:21:10 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:10 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 102ms Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 95ms Mar 14 13:21:10 volumio volumio[4339]: info: ------------------------------ 96ms Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:10 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:10 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:14 volumio volumio[4339]: info: Mar 14 13:21:14 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:14 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:14 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:14 volumio volumio[4339]: info: Mar 14 13:21:14 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:14 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:14 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:14 volumio volumio[4339]: info: sendMpdCommand status took 2 milliseconds Mar 14 13:21:14 volumio volumio[4339]: info: sendMpdCommand status took 2 milliseconds Mar 14 13:21:14 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:14 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:14 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:14 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:14 volumio volumio[4339]: 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} Mar 14 13:21:14 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::play index undefined Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:14 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:14 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:14 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:14 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:14 volumio volumio[4339]: 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} Mar 14 13:21:14 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:14 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:14 volumio volumio[4339]: info: No code Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:14 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:14 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:14 volumio volumio[4339]: info: ------------------------------ 39ms Mar 14 13:21:14 volumio volumio[4339]: info: ------------------------------ 38ms Mar 14 13:21:14 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:14 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:14 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:14 volumio volumio[4339]: info: Clearing queue after UPNP request Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::ClearQueue Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::stop Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:15 volumio volumio[4339]: info: CorePlayQueue::clearPlayQueue Mar 14 13:21:15 volumio volumio[4339]: info: CorePlayQueue::saveQueue Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::volumioPushQueue Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:21:15 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 3ms Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 3ms Mar 14 13:21:15 volumio volumio[4339]: info: Starting UPNP Playback Mar 14 13:21:15 volumio volumio[4339]: info: Preparing playback through UPNP Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::volumioGetState Mar 14 13:21:15 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:15 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:15 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:15 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:15 volumio volumio[4339]: info: sendMpdCommand status took 7 milliseconds Mar 14 13:21:15 volumio volumio[4339]: info: sendMpdCommand status took 6 milliseconds Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:15 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:15 volumio volumio[4339]: info: Mar 14 13:21:15 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:15 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:15 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 14 13:21:15 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 14 13:21:15 volumio volumio[4339]: info: sendMpdCommand status took 3 milliseconds Mar 14 13:21:15 volumio volumio[4339]: info: sendMpdCommand status took 2 milliseconds Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:15 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:15 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:15 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"紅い花","artist":"ちあきなおみ","album":"紅い花 (META)","uri":"http://m701.music.126.net/20250314214614/e9d812b761717ecf223c71c6630cf095/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36587199369/2150/efd9/df38/0b58ed063309c1de159b331e37d92fa7.m4a?vuutv=iJlzprfG35/VuuPWGrK6cf7jmAcYSMA5y8DK4PwHKYzdaTG2iGPeFINOUOFOPKzKHRw+0vm2lkTs1Zw0Gg85Jx9LxRpl4zchs5m3HrTcR0k=","trackType":""} Mar 14 13:21:15 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:15 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:15 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:15 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"紅い花","artist":"ちあきなおみ","album":"紅い花 (META)","uri":"http://m701.music.126.net/20250314214614/e9d812b761717ecf223c71c6630cf095/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36587199369/2150/efd9/df38/0b58ed063309c1de159b331e37d92fa7.m4a?vuutv=iJlzprfG35/VuuPWGrK6cf7jmAcYSMA5y8DK4PwHKYzdaTG2iGPeFINOUOFOPKzKHRw+0vm2lkTs1Zw0Gg85Jx9LxRpl4zchs5m3HrTcR0k=","trackType":""} Mar 14 13:21:15 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:15 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 38ms Mar 14 13:21:15 volumio volumio[4339]: info: ------------------------------ 37ms Mar 14 13:21:15 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 25 milliseconds Mar 14 13:21:15 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 25 milliseconds Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:15 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:15 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:15 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:15 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":774,"duration":302,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"紅い花","artist":"ちあきなおみ","album":"紅い花 (META)","uri":"http://m701.music.126.net/20250314214614/e9d812b761717ecf223c71c6630cf095/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36587199369/2150/efd9/df38/0b58ed063309c1de159b331e37d92fa7.m4a?vuutv=iJlzprfG35/VuuPWGrK6cf7jmAcYSMA5y8DK4PwHKYzdaTG2iGPeFINOUOFOPKzKHRw+0vm2lkTs1Zw0Gg85Jx9LxRpl4zchs5m3HrTcR0k=","trackType":""} Mar 14 13:21:15 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:15 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:15 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:15 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:16 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:16 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:16 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":302,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"紅い花","artist":"ちあきなおみ","album":"紅い花 (META)","uri":"http://m701.music.126.net/20250314214614/e9d812b761717ecf223c71c6630cf095/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36587199369/2150/efd9/df38/0b58ed063309c1de159b331e37d92fa7.m4a?vuutv=iJlzprfG35/VuuPWGrK6cf7jmAcYSMA5y8DK4PwHKYzdaTG2iGPeFINOUOFOPKzKHRw+0vm2lkTs1Zw0Gg85Jx9LxRpl4zchs5m3HrTcR0k=","trackType":""} Mar 14 13:21:16 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:16 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:16 volumio volumio[4339]: info: ------------------------------ 53ms Mar 14 13:21:16 volumio volumio[4339]: info: ------------------------------ 52ms Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:16 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:16 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:22 volumio volumio[4339]: info: Mar 14 13:21:22 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:22 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:22 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:22 volumio volumio[4339]: info: Mar 14 13:21:22 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:22 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:22 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:22 volumio volumio[4339]: info: sendMpdCommand status took 1 milliseconds Mar 14 13:21:22 volumio volumio[4339]: info: sendMpdCommand status took 1 milliseconds Mar 14 13:21:22 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:22 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:22 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:22 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:22 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 14 13:21:22 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 14 13:21:22 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:22 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:22 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:22 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:22 volumio volumio[4339]: 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":"紅い花 (META)","uri":"http://m701.music.126.net/20250314214614/e9d812b761717ecf223c71c6630cf095/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36587199369/2150/efd9/df38/0b58ed063309c1de159b331e37d92fa7.m4a?vuutv=iJlzprfG35/VuuPWGrK6cf7jmAcYSMA5y8DK4PwHKYzdaTG2iGPeFINOUOFOPKzKHRw+0vm2lkTs1Zw0Gg85Jx9LxRpl4zchs5m3HrTcR0k=","trackType":""} Mar 14 13:21:22 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::play index undefined Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:22 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:22 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:22 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:22 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:22 volumio volumio[4339]: 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":"紅い花 (META)","uri":"http://m701.music.126.net/20250314214614/e9d812b761717ecf223c71c6630cf095/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36587199369/2150/efd9/df38/0b58ed063309c1de159b331e37d92fa7.m4a?vuutv=iJlzprfG35/VuuPWGrK6cf7jmAcYSMA5y8DK4PwHKYzdaTG2iGPeFINOUOFOPKzKHRw+0vm2lkTs1Zw0Gg85Jx9LxRpl4zchs5m3HrTcR0k=","trackType":""} Mar 14 13:21:22 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:22 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:22 volumio volumio[4339]: info: No code Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:22 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:22 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:22 volumio volumio[4339]: info: ------------------------------ 39ms Mar 14 13:21:22 volumio volumio[4339]: info: ------------------------------ 39ms Mar 14 13:21:22 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:22 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:22 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:22 volumio volumio[4339]: info: Clearing queue after UPNP request Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::ClearQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::stop Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::clearPlayQueue Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::saveQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushQueue Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:21:23 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: Starting UPNP Playback Mar 14 13:21:23 volumio volumio[4339]: info: Preparing playback through UPNP Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioGetState Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:23 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:23 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:23 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:23 volumio volumio[4339]: info: sendMpdCommand status took 10 milliseconds Mar 14 13:21:23 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:23 volumio volumio[4339]: info: sendMpdCommand status took 10 milliseconds Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:23 volumio volumio[4339]: info: Mar 14 13:21:23 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:23 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:23 volumio volumio[4339]: info: sendMpdCommand status took 4 milliseconds Mar 14 13:21:23 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:23 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:23 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:23 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":425,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲菲","album":"那些年","uri":"http://m701.music.126.net/20250314214622/9c9ef86aeae9ce9d0264379823f89f31/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26943957257/52e8/389e/7906/21b1a30b9ab1cfc5c065169fa68ef8ee.m4a?vuutv=Up+a2BoivQT6gNHFbOBse2aQHuV3XPa3lVHWeTsg5GuHXh09UE7YHTQ85CUBOVptAptaQZMOFRN5g1nnKQfvZ7GAfTJjNV7Z80OJ+YA/y2s=","trackType":""} Mar 14 13:21:23 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 23ms Mar 14 13:21:23 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 14 13:21:23 volumio volumio[4339]: info: sendMpdCommand status took 11 milliseconds Mar 14 13:21:23 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:23 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:23 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:23 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":425,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲菲","album":"那些年","uri":"http://m701.music.126.net/20250314214622/9c9ef86aeae9ce9d0264379823f89f31/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26943957257/52e8/389e/7906/21b1a30b9ab1cfc5c065169fa68ef8ee.m4a?vuutv=Up+a2BoivQT6gNHFbOBse2aQHuV3XPa3lVHWeTsg5GuHXh09UE7YHTQ85CUBOVptAptaQZMOFRN5g1nnKQfvZ7GAfTJjNV7Z80OJ+YA/y2s=","trackType":""} Mar 14 13:21:23 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:23 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:23 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:23 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:23 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":425,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲菲","album":"那些年","uri":"http://m701.music.126.net/20250314214622/9c9ef86aeae9ce9d0264379823f89f31/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26943957257/52e8/389e/7906/21b1a30b9ab1cfc5c065169fa68ef8ee.m4a?vuutv=Up+a2BoivQT6gNHFbOBse2aQHuV3XPa3lVHWeTsg5GuHXh09UE7YHTQ85CUBOVptAptaQZMOFRN5g1nnKQfvZ7GAfTJjNV7Z80OJ+YA/y2s=","trackType":""} Mar 14 13:21:23 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:23 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 52ms Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 43ms Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 37 milliseconds Mar 14 13:21:23 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:23 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:23 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:23 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":425,"samplerate":"11.025 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲菲","album":"那些年","uri":"http://m701.music.126.net/20250314214622/9c9ef86aeae9ce9d0264379823f89f31/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26943957257/52e8/389e/7906/21b1a30b9ab1cfc5c065169fa68ef8ee.m4a?vuutv=Up+a2BoivQT6gNHFbOBse2aQHuV3XPa3lVHWeTsg5GuHXh09UE7YHTQ85CUBOVptAptaQZMOFRN5g1nnKQfvZ7GAfTJjNV7Z80OJ+YA/y2s=","trackType":""} Mar 14 13:21:23 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:23 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:23 volumio volumio[4339]: info: ------------------------------ 65ms Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:23 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:23 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:27 volumio volumio[4339]: info: Mar 14 13:21:27 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:27 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:27 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:27 volumio volumio[4339]: info: Mar 14 13:21:27 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:27 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:27 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:27 volumio volumio[4339]: info: sendMpdCommand status took 3 milliseconds Mar 14 13:21:27 volumio volumio[4339]: info: sendMpdCommand status took 2 milliseconds Mar 14 13:21:27 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:27 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:27 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:27 volumio volumio[4339]: 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} Mar 14 13:21:27 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::play index undefined Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:27 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:27 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:27 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:27 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:27 volumio volumio[4339]: 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} Mar 14 13:21:27 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:27 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:27 volumio volumio[4339]: info: No code Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:27 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:27 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:27 volumio volumio[4339]: info: ------------------------------ 38ms Mar 14 13:21:27 volumio volumio[4339]: info: ------------------------------ 38ms Mar 14 13:21:27 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:27 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:27 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:45 volumio volumio[4339]: info: Clearing queue after UPNP request Mar 14 13:21:45 volumio volumio[4339]: info: CoreStateMachine::ClearQueue Mar 14 13:21:45 volumio volumio[4339]: info: CoreStateMachine::stop Mar 14 13:21:45 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:45 volumio volumio[4339]: info: CorePlayQueue::clearPlayQueue Mar 14 13:21:45 volumio volumio[4339]: info: CorePlayQueue::saveQueue Mar 14 13:21:45 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:45 volumio volumio[4339]: info: CoreCommandRouter::volumioPushQueue Mar 14 13:21:45 volumio volumio[4339]: info: Mar 14 13:21:45 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:45 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:45 volumio volumio[4339]: info: Mar 14 13:21:45 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:45 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:45 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:21:45 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:21:45 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:45 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:45 volumio volumio[4339]: info: Starting UPNP Playback Mar 14 13:21:45 volumio volumio[4339]: info: Preparing playback through UPNP Mar 14 13:21:45 volumio volumio[4339]: info: CoreCommandRouter::volumioGetState Mar 14 13:21:45 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:45 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:21:46 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 3ms Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:46 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:46 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:46 volumio volumio[4339]: info: sendMpdCommand status took 21 milliseconds Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:46 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:46 volumio volumio[4339]: info: sendMpdCommand status took 21 milliseconds Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:46 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:46 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:46 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:46 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":175,"samplerate":"32 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿（原唱：王菲）","artist":"UNNC Choir","album":"如愿","uri":"http://m701.music.126.net/20250314214645/ff2332b58434b77c4ab315990f093d52/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/23842677545/3da0/3981/8cfb/c0d5efb3d4b8958eec38a7af96a28ec8.m4a?vuutv=pCG4QVjGR0jxS9lUhX28eEOjgT03fdQ96so7mKzQ1J19OEYxaGWvMJN/RKEmpBig7yEJa8r2IouzXmnC0q8H8If8XaYY/OtoaSHI6kRFqsQ=","trackType":""} Mar 14 13:21:46 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 31ms Mar 14 13:21:46 volumio volumio[4339]: info: Mar 14 13:21:46 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:46 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:46 volumio volumio[4339]: info: sendMpdCommand status took 10 milliseconds Mar 14 13:21:46 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:46 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:46 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:46 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":175,"samplerate":"32 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿（原唱：王菲）","artist":"UNNC Choir","album":"如愿","uri":"http://m701.music.126.net/20250314214645/ff2332b58434b77c4ab315990f093d52/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/23842677545/3da0/3981/8cfb/c0d5efb3d4b8958eec38a7af96a28ec8.m4a?vuutv=pCG4QVjGR0jxS9lUhX28eEOjgT03fdQ96so7mKzQ1J19OEYxaGWvMJN/RKEmpBig7yEJa8r2IouzXmnC0q8H8If8XaYY/OtoaSHI6kRFqsQ=","trackType":""} Mar 14 13:21:46 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:46 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 48ms Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: sendMpdCommand status took 24 milliseconds Mar 14 13:21:46 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:46 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:46 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:46 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":175,"samplerate":"32 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿（原唱：王菲）","artist":"UNNC Choir","album":"如愿","uri":"http://m701.music.126.net/20250314214645/ff2332b58434b77c4ab315990f093d52/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/23842677545/3da0/3981/8cfb/c0d5efb3d4b8958eec38a7af96a28ec8.m4a?vuutv=pCG4QVjGR0jxS9lUhX28eEOjgT03fdQ96so7mKzQ1J19OEYxaGWvMJN/RKEmpBig7yEJa8r2IouzXmnC0q8H8If8XaYY/OtoaSHI6kRFqsQ=","trackType":""} Mar 14 13:21:46 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:46 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 54ms Mar 14 13:21:46 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 19 milliseconds Mar 14 13:21:46 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:21:46 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:46 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:21:46 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":175,"samplerate":"32 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿（原唱：王菲）","artist":"UNNC Choir","album":"如愿","uri":"http://m701.music.126.net/20250314214645/ff2332b58434b77c4ab315990f093d52/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/23842677545/3da0/3981/8cfb/c0d5efb3d4b8958eec38a7af96a28ec8.m4a?vuutv=pCG4QVjGR0jxS9lUhX28eEOjgT03fdQ96so7mKzQ1J19OEYxaGWvMJN/RKEmpBig7yEJa8r2IouzXmnC0q8H8If8XaYY/OtoaSHI6kRFqsQ=","trackType":""} Mar 14 13:21:46 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:46 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:46 volumio volumio[4339]: info: ------------------------------ 61ms Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:46 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:46 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:21:47 volumio volumio[4339]: info: Mar 14 13:21:47 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:47 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:47 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:47 volumio volumio[4339]: info: Mar 14 13:21:47 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:21:47 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:21:47 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:21:47 volumio volumio[4339]: info: sendMpdCommand status took 4 milliseconds Mar 14 13:21:47 volumio volumio[4339]: info: sendMpdCommand status took 3 milliseconds Mar 14 13:21:47 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:21:47 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:47 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:47 volumio volumio[4339]: 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} Mar 14 13:21:47 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::play index undefined Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:47 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:47 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:47 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:47 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:47 volumio volumio[4339]: 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} Mar 14 13:21:47 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:47 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:47 volumio volumio[4339]: info: No code Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:21:47 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:21:47 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:21:47 volumio volumio[4339]: info: ------------------------------ 39ms Mar 14 13:21:47 volumio volumio[4339]: info: ------------------------------ 39ms Mar 14 13:21:47 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:21:47 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:21:47 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:12 volumio volumio[4339]: info: Clearing queue after UPNP request Mar 14 13:22:12 volumio volumio[4339]: info: CoreStateMachine::ClearQueue Mar 14 13:22:12 volumio volumio[4339]: info: CoreStateMachine::stop Mar 14 13:22:12 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:22:12 volumio volumio[4339]: info: CorePlayQueue::clearPlayQueue Mar 14 13:22:12 volumio volumio[4339]: info: CorePlayQueue::saveQueue Mar 14 13:22:12 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:12 volumio volumio[4339]: info: CoreCommandRouter::volumioPushQueue Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 6ms Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:12 volumio volumio[4339]: info: Starting UPNP Playback Mar 14 13:22:12 volumio volumio[4339]: info: Preparing playback through UPNP Mar 14 13:22:12 volumio volumio[4339]: info: CoreCommandRouter::volumioGetState Mar 14 13:22:12 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:12 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:12 volumio volumio[4339]: info: Mar 14 13:22:12 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:12 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:12 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:13 volumio volumio[4339]: info: Mar 14 13:22:13 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:13 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:13 volumio volumio[4339]: info: Mar 14 13:22:13 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:13 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:13 volumio volumio[4339]: info: Mar 14 13:22:13 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:13 volumio volumio[4339]: info: sendMpdCommand status took 19 milliseconds Mar 14 13:22:13 volumio volumio[4339]: info: sendMpdCommand status took 18 milliseconds Mar 14 13:22:13 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:13 volumio volumio[4339]: info: Mar 14 13:22:13 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:13 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:13 volumio volumio[4339]: info: sendMpdCommand status took 2 milliseconds Mar 14 13:22:13 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 14 13:22:13 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:13 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:13 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:22:13 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"如愿（电影《我和我的父辈》推广曲）","artist":"王梓琪","album":"如愿","uri":"http://m701.music.126.net/20250314214712/b6d015b5800b1d1635c13ca9552a307f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/13898799925/1a31/e4b3/02d9/0efc26fda5050c1b4c952ea94ddc0660.m4a?vuutv=0+tY9Go+ko9UQDdBV0IstI82UsHxwMYTOxVtQZ/Tp8N7rByzEPGL2Bg+urOzCo0q6i/LfCCyXunuxdkoxuC1clTiNt4JYkBIsFeTKygJ13Q=","trackType":""} Mar 14 13:22:13 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:13 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:13 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:22:13 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"如愿（电影《我和我的父辈》推广曲）","artist":"王梓琪","album":"如愿","uri":"http://m701.music.126.net/20250314214712/b6d015b5800b1d1635c13ca9552a307f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/13898799925/1a31/e4b3/02d9/0efc26fda5050c1b4c952ea94ddc0660.m4a?vuutv=0+tY9Go+ko9UQDdBV0IstI82UsHxwMYTOxVtQZ/Tp8N7rByzEPGL2Bg+urOzCo0q6i/LfCCyXunuxdkoxuC1clTiNt4JYkBIsFeTKygJ13Q=","trackType":""} Mar 14 13:22:13 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:22:13 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:13 volumio volumio[4339]: info: ------------------------------ 51ms Mar 14 13:22:13 volumio volumio[4339]: info: ------------------------------ 51ms Mar 14 13:22:13 volumio volumio[4339]: info: sendMpdCommand status took 31 milliseconds Mar 14 13:22:13 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:13 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:13 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:22:13 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93,"duration":264,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"如愿（电影《我和我的父辈》推广曲）","artist":"王梓琪","album":"如愿","uri":"http://m701.music.126.net/20250314214712/b6d015b5800b1d1635c13ca9552a307f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/13898799925/1a31/e4b3/02d9/0efc26fda5050c1b4c952ea94ddc0660.m4a?vuutv=0+tY9Go+ko9UQDdBV0IstI82UsHxwMYTOxVtQZ/Tp8N7rByzEPGL2Bg+urOzCo0q6i/LfCCyXunuxdkoxuC1clTiNt4JYkBIsFeTKygJ13Q=","trackType":""} Mar 14 13:22:13 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:22:13 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:13 volumio volumio[4339]: info: ------------------------------ 54ms Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 46 milliseconds Mar 14 13:22:13 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:13 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:13 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:22:13 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125,"duration":264,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"如愿（电影《我和我的父辈》推广曲）","artist":"王梓琪","album":"如愿","uri":"http://m701.music.126.net/20250314214712/b6d015b5800b1d1635c13ca9552a307f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/13898799925/1a31/e4b3/02d9/0efc26fda5050c1b4c952ea94ddc0660.m4a?vuutv=0+tY9Go+ko9UQDdBV0IstI82UsHxwMYTOxVtQZ/Tp8N7rByzEPGL2Bg+urOzCo0q6i/LfCCyXunuxdkoxuC1clTiNt4JYkBIsFeTKygJ13Q=","trackType":""} Mar 14 13:22:13 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:22:13 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:13 volumio volumio[4339]: info: ------------------------------ 107ms Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:13 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:13 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:24 volumio volumio[4339]: info: Mar 14 13:22:24 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:24 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:24 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:24 volumio volumio[4339]: info: Mar 14 13:22:24 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:24 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:24 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:24 volumio volumio[4339]: info: sendMpdCommand status took 3 milliseconds Mar 14 13:22:24 volumio volumio[4339]: info: sendMpdCommand status took 3 milliseconds Mar 14 13:22:24 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:24 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:24 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:24 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:24 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 14 13:22:24 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 14 13:22:24 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:24 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:24 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:24 volumio volumio[4339]: 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/20250314214712/b6d015b5800b1d1635c13ca9552a307f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/13898799925/1a31/e4b3/02d9/0efc26fda5050c1b4c952ea94ddc0660.m4a?vuutv=0+tY9Go+ko9UQDdBV0IstI82UsHxwMYTOxVtQZ/Tp8N7rByzEPGL2Bg+urOzCo0q6i/LfCCyXunuxdkoxuC1clTiNt4JYkBIsFeTKygJ13Q=","trackType":""} Mar 14 13:22:24 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::play index undefined Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:24 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:24 volumio volumio[4339]: 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/20250314214712/b6d015b5800b1d1635c13ca9552a307f/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/13898799925/1a31/e4b3/02d9/0efc26fda5050c1b4c952ea94ddc0660.m4a?vuutv=0+tY9Go+ko9UQDdBV0IstI82UsHxwMYTOxVtQZ/Tp8N7rByzEPGL2Bg+urOzCo0q6i/LfCCyXunuxdkoxuC1clTiNt4JYkBIsFeTKygJ13Q=","trackType":""} Mar 14 13:22:24 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::syncState stateService stop Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:24 volumio volumio[4339]: info: No code Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:24 volumio volumio[4339]: info: ------------------------------ 43ms Mar 14 13:22:24 volumio volumio[4339]: info: ------------------------------ 42ms Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:24 volumio volumio[4339]: info: Clearing queue after UPNP request Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::ClearQueue Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::stop Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::clearPlayQueue Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::saveQueue Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioPushQueue Mar 14 13:22:24 volumio volumio[4339]: info: Mar 14 13:22:24 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:24 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:24 volumio volumio[4339]: info: Mar 14 13:22:24 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:24 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:24 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:22:24 volumio volumio[4339]: error: updateQueue error: null Mar 14 13:22:24 volumio volumio[4339]: info: ------------------------------ 7ms Mar 14 13:22:24 volumio volumio[4339]: info: ------------------------------ 4ms Mar 14 13:22:24 volumio volumio[4339]: info: Starting UPNP Playback Mar 14 13:22:24 volumio volumio[4339]: info: Preparing playback through UPNP Mar 14 13:22:24 volumio volumio[4339]: info: CoreCommandRouter::volumioGetState Mar 14 13:22:24 volumio volumio[4339]: info: CorePlayQueue::getTrack 0 Mar 14 13:22:24 volumio volumio[4339]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 2ms Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces system playlist update Mar 14 13:22:25 volumio volumio[4339]: info: Ignoring MPD Status Update Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 1ms Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:25 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:25 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:25 volumio volumio[4339]: info: sendMpdCommand status took 20 milliseconds Mar 14 13:22:25 volumio volumio[4339]: info: sendMpdCommand status took 19 milliseconds Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:25 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:25 volumio volumio[4339]: info: Mar 14 13:22:25 volumio volumio[4339]: ---------------------------- MPD announces state update: player Mar 14 13:22:25 volumio volumio[4339]: info: ControllerMpd::getState Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand status Mar 14 13:22:25 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 14 13:22:25 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 14 13:22:25 volumio volumio[4339]: info: sendMpdCommand status took 2 milliseconds Mar 14 13:22:25 volumio volumio[4339]: info: sendMpdCommand status took 2 milliseconds Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::parseState Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 14 13:22:25 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:25 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:22:25 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"如愿-王菲(cover by omimimanny)","artist":"omimimanny","album":"Faye","uri":"http://m701.music.126.net/20250314214724/67d61015d9096c79261663be1b04a115/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/20292862933/d727/b51c/15ac/04d5be856f429322cb05d79e0a768405.m4a?vuutv=5NVEX8709uCliRL+i7xJ2utlwQb6IGLcu7xLSc7dJ4pi3eZFMBSPDZkPg1rW20MeRexuIqTEpCG2QIzezIMFOfZhVbegrbjFEx9ioPkFLrQ=","trackType":""} Mar 14 13:22:25 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus stop Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:25 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:25 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:22:25 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79,"duration":266,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"如愿-王菲(cover by omimimanny)","artist":"omimimanny","album":"Faye","uri":"http://m701.music.126.net/20250314214724/67d61015d9096c79261663be1b04a115/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/20292862933/d727/b51c/15ac/04d5be856f429322cb05d79e0a768405.m4a?vuutv=5NVEX8709uCliRL+i7xJ2utlwQb6IGLcu7xLSc7dJ4pi3eZFMBSPDZkPg1rW20MeRexuIqTEpCG2QIzezIMFOfZhVbegrbjFEx9ioPkFLrQ=","trackType":""} Mar 14 13:22:25 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:22:25 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 65ms Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 65ms Mar 14 13:22:25 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 41 milliseconds Mar 14 13:22:25 volumio volumio[4339]: info: sendMpdCommand playlistinfo took 40 milliseconds Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:25 volumio volumio[4339]: verbose: ControllerMpd::parseTrackInfo Mar 14 13:22:25 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:25 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:22:25 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":266,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"如愿-王菲(cover by omimimanny)","artist":"omimimanny","album":"Faye","uri":"http://m701.music.126.net/20250314214724/67d61015d9096c79261663be1b04a115/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/20292862933/d727/b51c/15ac/04d5be856f429322cb05d79e0a768405.m4a?vuutv=5NVEX8709uCliRL+i7xJ2utlwQb6IGLcu7xLSc7dJ4pi3eZFMBSPDZkPg1rW20MeRexuIqTEpCG2QIzezIMFOfZhVbegrbjFEx9ioPkFLrQ=","trackType":""} Mar 14 13:22:25 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:22:25 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:25 volumio volumio[4339]: info: ControllerMpd::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::servicePushState Mar 14 13:22:25 volumio volumio[4339]: verbose: In UPNP mode Mar 14 13:22:25 volumio volumio[4339]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":266,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"如愿-王菲(cover by omimimanny)","artist":"omimimanny","album":"Faye","uri":"http://m701.music.126.net/20250314214724/67d61015d9096c79261663be1b04a115/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/20292862933/d727/b51c/15ac/04d5be856f429322cb05d79e0a768405.m4a?vuutv=5NVEX8709uCliRL+i7xJ2utlwQb6IGLcu7xLSc7dJ4pi3eZFMBSPDZkPg1rW20MeRexuIqTEpCG2QIzezIMFOfZhVbegrbjFEx9ioPkFLrQ=","trackType":""} Mar 14 13:22:25 volumio volumio[4339]: verbose: CURRENT POSITION 0 Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::syncState stateService play Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::syncState currentStatus play Mar 14 13:22:25 volumio volumio[4339]: info: Received an update from plugin. extracting info from payload Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::pushState Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioPushState Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 83ms Mar 14 13:22:25 volumio volumio[4339]: info: ------------------------------ 83ms Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreCommandRouter::volumioGetQueue Mar 14 13:22:25 volumio volumio[4339]: info: CoreStateMachine::getQueue Mar 14 13:22:25 volumio volumio[4339]: info: CorePlayQueue::getQueue Mar 14 13:22:36 volumio volumio[4339]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 13:22:36 volumio volumio[4339]: Error: connect ETIMEDOUT 31.13.75.5:443 Mar 14 13:22:36 volumio volumio[4339]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 14 13:22:36 volumio volumio[4339]: errno: -110, Mar 14 13:22:36 volumio volumio[4339]: code: 'ETIMEDOUT', Mar 14 13:22:36 volumio volumio[4339]: syscall: 'connect', Mar 14 13:22:36 volumio volumio[4339]: address: '31.13.75.5', Mar 14 13:22:36 volumio volumio[4339]: port: 443 Mar 14 13:22:36 volumio volumio[4339]: } Mar 14 13:22:36 volumio volumio[4339]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 13:22:36 volumio sudo[10614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-14 13:21 Mar 14 13:22:36 volumio sudo[10614]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 11:12:31 AM CEST" VOLUMIO_VERSION="3.378" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4d8af4ba9bde4fed178dd6b058b1d778"