Dec 30 02:15:26 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::stPlaybackTimer
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::updateTrackBlock
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrackBlock
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::serviceStop
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: ControllerMpd::stop
Dec 30 02:15:26 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand stop
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:15:26 volumio volumio[8607]: info:
Dec 30 02:15:26 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:26 volumio volumio[8607]: info: sendMpdCommand stop took 5 milliseconds
Dec 30 02:15:26 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:26 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:26 volumio volumio[8607]: info:
Dec 30 02:15:26 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:26 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:26 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:26 volumio volumio[8607]: info:
Dec 30 02:15:26 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:26 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:26 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:26 volumio volumio[8607]: info:
Dec 30 02:15:26 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:26 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:26 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:26 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:26 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:26 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:26 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:26 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:26 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:26 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: No code
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:26 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: No code
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:26 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: No code
Dec 30 02:15:26 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:26 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:26 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:26 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:15:26 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:15:26 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:15:26 volumio volumio[8607]: info:
Dec 30 02:15:26 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:26 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:26 volumio volumio[8607]: info:
Dec 30 02:15:26 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:26 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:26 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:26 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:26 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:26 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:15:26 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:26 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:15:27 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:15:27 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:15:27 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:15:27 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:15:27 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:15:27 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:27 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:27 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: Starting UPNP Playback
Dec 30 02:15:27 volumio volumio[8607]: info: Preparing playback through UPNP
Dec 30 02:15:27 volumio volumio[8607]: info: CoreCommandRouter::volumioGetState
Dec 30 02:15:27 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:27 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info:
Dec 30 02:15:27 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:27 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:27 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿你今夜别离去","artist":"黎明","album":"真经典 - 黎明","uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿你今夜别离去","artist":"黎明","album":"真经典 - 黎明","uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:28 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿你今夜别离去","artist":"黎明","album":"真经典 - 黎明","uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:28 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿你今夜别离去","artist":"黎明","album":"真经典 - 黎明","uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:28 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 11ms
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 11ms
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 11ms
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:28 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 10 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 9 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿你今夜别离去","artist":"黎明","album":"真经典 - 黎明","uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:28 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"愿你今夜别离去","artist":"黎明","album":"真经典 - 黎明","uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:28 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 18ms
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 18ms
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:28 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:28 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:28 volumio volumio[8607]: info:
Dec 30 02:15:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 14ms
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 14 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:28 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:28 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:28 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":297,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104027/bddd52c80c6971f24857a69ca7289c6d/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31672529760/c2b3/61e0/7830/3a3c7e707ad3556d4f4388ef6365978b.mp3?vuutv=3oD47/JiTLoyOx/ALrpP8lhvRkptG6/ZTx+K9ygaqRAPeeSHtqqvfDIZ9bt2Q3kSoKNVGGjqcidTD0zN6VXvA5Q+KUFu7VbRE33rlhAe5RQ=","trackType":""}
Dec 30 02:15:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:28 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 24ms
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 10ms
Dec 30 02:15:28 volumio volumio[8607]: info: ------------------------------ 10ms
Dec 30 02:15:33 volumio volumio[8607]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%8E%E6%98%8E/%E7%83%9F%E7%81%AB/b14e808e-370c-43ee-988d-90a908e49a2d.png'
Dec 30 02:15:42 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::stPlaybackTimer
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::updateTrackBlock
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrackBlock
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::serviceStop
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: ControllerMpd::stop
Dec 30 02:15:43 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand stop
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:43 volumio volumio[8607]: info: sendMpdCommand stop took 4 milliseconds
Dec 30 02:15:43 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:43 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:43 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:43 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:43 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:43 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:43 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:43 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:43 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:43 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:43 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:43 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:43 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:43 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:43 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: No code
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:43 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: No code
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:43 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: No code
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:43 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:43 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:43 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:15:43 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:43 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 4ms
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 4ms
Dec 30 02:15:43 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:43 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:43 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:43 volumio volumio[8607]: info:
Dec 30 02:15:43 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:43 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:43 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:43 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:43 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:43 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:43 volumio volumio[8607]: info: Starting UPNP Playback
Dec 30 02:15:43 volumio volumio[8607]: info: Preparing playback through UPNP
Dec 30 02:15:43 volumio volumio[8607]: info: CoreCommandRouter::volumioGetState
Dec 30 02:15:43 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:43 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"越夜越有机","artist":"黎明","album":"北京站","uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"越夜越有机","artist":"黎明","album":"北京站","uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:44 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"越夜越有机","artist":"黎明","album":"北京站","uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:44 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 7ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 7ms
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 7 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 7 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"越夜越有机","artist":"黎明","album":"北京站","uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:44 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"越夜越有机","artist":"黎明","album":"北京站","uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:44 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"越夜越有机","artist":"黎明","album":"北京站","uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:44 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 18ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 17ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 17ms
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:44 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:44 volumio volumio[8607]: info:
Dec 30 02:15:44 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 16ms
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 16 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:44 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:44 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:44 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:44 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104043/aedde355299a123cab093d465889c497/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14099962226/0d7b/0420/4840/c315cbfc5047d011de34dea1c232362a.mp3?vuutv=HnNBikYF9bqp7xpCaSG8hpWkSsc2/9yYprHCXvDSHlIfrejb8WZJd52RpmHFtxuEjMkF4OJ1J5j3/OuJsYfha0xGTTnSuWnsAiIoo1lRrrs=","trackType":""}
Dec 30 02:15:44 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:44 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:44 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 24ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 9ms
Dec 30 02:15:44 volumio volumio[8607]: info: ------------------------------ 9ms
Dec 30 02:15:53 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::stPlaybackTimer
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::updateTrackBlock
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrackBlock
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::serviceStop
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: ControllerMpd::stop
Dec 30 02:15:54 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand stop
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:54 volumio volumio[8607]: info: sendMpdCommand stop took 3 milliseconds
Dec 30 02:15:54 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:54 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:54 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:54 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:54 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:54 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:54 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:54 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:54 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:54 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:54 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:54 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:54 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:54 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:54 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: No code
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:54 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: No code
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:15:54 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: No code
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:54 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:54 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:54 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:54 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:54 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 5ms
Dec 30 02:15:54 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:54 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:54 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:54 volumio volumio[8607]: info:
Dec 30 02:15:54 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:54 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:54 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:54 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:54 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:54 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:54 volumio volumio[8607]: info: Starting UPNP Playback
Dec 30 02:15:54 volumio volumio[8607]: info: Preparing playback through UPNP
Dec 30 02:15:54 volumio volumio[8607]: info: CoreCommandRouter::volumioGetState
Dec 30 02:15:54 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:15:54 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"全日爱","artist":"黎明","album":"Club Sandwich","uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"全日爱","artist":"黎明","album":"Club Sandwich","uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:55 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"全日爱","artist":"黎明","album":"Club Sandwich","uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:55 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"全日爱","artist":"黎明","album":"Club Sandwich","uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:55 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"全日爱","artist":"黎明","album":"Club Sandwich","uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:55 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 17ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 17ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 17ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 17ms
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 15 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","artist":null,"album":null,"uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:55 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 21ms
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:15:55 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:15:55 volumio volumio[8607]: info:
Dec 30 02:15:55 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 11ms
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 11 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","artist":null,"album":null,"uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:55 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","artist":null,"album":null,"uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:55 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:15:55 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:15:55 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","artist":null,"album":null,"uri":"http://m801.music.126.net/20251230104054/f44ffddc508b363b6626f4923de029d0/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495508470/ae8d/c892/2bb5/2f2c885d1365eba1fb111d111e0141ac.mp3?vuutv=vUkj8pf1eihh4hpmQGA9ptqVnxeYd9FhbhZrb1twMD5kYrAlT44W36nPU1WGv6jKyb7/LJZdCXRj/guzhZUtNV2dcEHGhBsqwCOP0Q2orYY=","trackType":""}
Dec 30 02:15:55 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:15:55 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:15:55 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 21ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 10ms
Dec 30 02:15:55 volumio volumio[8607]: info: ------------------------------ 10ms
Dec 30 02:16:09 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::stPlaybackTimer
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::updateTrackBlock
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrackBlock
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::serviceStop
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: ControllerMpd::stop
Dec 30 02:16:09 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand stop
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:16:09 volumio volumio[8607]: info:
Dec 30 02:16:09 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:09 volumio volumio[8607]: info: sendMpdCommand stop took 4 milliseconds
Dec 30 02:16:09 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:09 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:09 volumio volumio[8607]: info:
Dec 30 02:16:09 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:09 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:09 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:09 volumio volumio[8607]: info:
Dec 30 02:16:09 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:09 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:09 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:09 volumio volumio[8607]: info:
Dec 30 02:16:09 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:09 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:09 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:09 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:09 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:09 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:09 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:09 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:09 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:09 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: No code
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:09 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: No code
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:09 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: No code
Dec 30 02:16:09 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:09 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:09 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:09 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:16:09 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:16:09 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:16:09 volumio volumio[8607]: info:
Dec 30 02:16:09 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:09 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:09 volumio volumio[8607]: info:
Dec 30 02:16:09 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:09 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:09 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:09 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:09 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:09 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:16:09 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:09 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:09 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:10 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:10 volumio volumio[8607]: info: Starting UPNP Playback
Dec 30 02:16:10 volumio volumio[8607]: info: Preparing playback through UPNP
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetState
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我会像你一样傻","artist":"黎明","album":"但愿不只是朋友","uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我会像你一样傻","artist":"黎明","album":"但愿不只是朋友","uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:10 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我会像你一样傻","artist":"黎明","album":"但愿不只是朋友","uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:10 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我会像你一样傻","artist":"黎明","album":"但愿不只是朋友","uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:10 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我会像你一样傻","artist":"黎明","album":"但愿不只是朋友","uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:10 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 14ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 12 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我会像你一样傻","artist":"黎明","album":"但愿不只是朋友","uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:10 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 18ms
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:10 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:10 volumio volumio[8607]: info:
Dec 30 02:16:10 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 11 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand status took 2 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","artist":null,"album":null,"uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:10 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","artist":null,"album":null,"uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:10 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 21ms
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 10ms
Dec 30 02:16:10 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 8 milliseconds
Dec 30 02:16:10 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:10 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:10 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:10 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","artist":null,"album":null,"uri":"http://m801.music.126.net/20251230104109/5cf486d933e7ea0e5bb9b0e39f46fecc/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/31673877116/3e10/6862/832f/bb0464fea614a06d443d42c401ad81b0.mp3?vuutv=+wRIY6QiHSR9AAGWd27Rv20OruiKYzSicIm80YhJLBFaA6jttex8iYgjWgDmMzXuYiWSemU7vH/CFCo9gcwiQ5OMjN88FS3v2isZGlNUB8M=","trackType":""}
Dec 30 02:16:10 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:10 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:10 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:10 volumio volumio[8607]: info: ------------------------------ 14ms
Dec 30 02:16:14 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::stPlaybackTimer
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::updateTrackBlock
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrackBlock
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::serviceStop
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: ControllerMpd::stop
Dec 30 02:16:14 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand stop
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:14 volumio volumio[8607]: info: sendMpdCommand stop took 6 milliseconds
Dec 30 02:16:14 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:14 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:14 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:14 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:14 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:14 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:14 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:14 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:14 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:14 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:14 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:14 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:14 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:14 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:14 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: No code
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:14 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: No code
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:14 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: No code
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 18ms
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 19ms
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 19ms
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:14 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:14 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:14 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:14 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:14 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 18ms
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:14 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:14 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:14 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:14 volumio volumio[8607]: info:
Dec 30 02:16:14 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:14 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:14 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:14 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:14 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:14 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:14 volumio volumio[8607]: info: Starting UPNP Playback
Dec 30 02:16:14 volumio volumio[8607]: info: Preparing playback through UPNP
Dec 30 02:16:14 volumio volumio[8607]: info: CoreCommandRouter::volumioGetState
Dec 30 02:16:14 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:14 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Happy 2000","artist":"黎明","album":"如果可以再见你","uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 2ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Happy 2000","artist":"黎明","album":"如果可以再见你","uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:15 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Happy 2000","artist":"黎明","album":"如果可以再见你","uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:15 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Happy 2000","artist":"黎明","album":"如果可以再见你","uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:15 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Happy 2000","artist":"黎明","album":"如果可以再见你","uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:15 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 19ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 19ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 19ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 20ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 18 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:15 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 25ms
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:15 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:15 volumio volumio[8607]: info:
Dec 30 02:16:15 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 14ms
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 14 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 8ms
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 8 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 9ms
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand status took 8 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:15 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:15 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:15 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:15 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","artist":null,"album":null,"uri":"http://m701.music.126.net/20251230104114/3ce29ffe5b75e777663fd6b1d6d48c9c/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/4495512425/302d/5dc5/26db/5457b6f59bca5a50dc186314fdb52e13.mp3?vuutv=zuzP18VzcufFSO+HH+s2FT4PGaQLPaiVF212Da4+oXmH9SP+QybWm4/LZjod7eIIWC7FxYeeuVhRkMWr3fj+b3j+KDYFI+VXlwk8gpbtj2o=","trackType":""}
Dec 30 02:16:15 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:15 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:15 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 29ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 23ms
Dec 30 02:16:15 volumio volumio[8607]: info: ------------------------------ 23ms
Dec 30 02:16:21 volumio volumio[8607]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%8E%E6%98%8E/%E5%8C%97%E4%BA%AC%E7%AB%99/2e5d66b7-ee18-4120-b589-c62c0548d6e3.jpg'
Dec 30 02:16:21 volumio volumio[8607]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%8E%E6%98%8E/%E5%8C%97%E4%BA%AC%E7%AB%99/2e5d66b7-ee18-4120-b589-c62c0548d6e3.jpg'
Dec 30 02:16:21 volumio volumio[8607]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%8E%E6%98%8E/Club%20Sandwich/9bd775fd-468c-44a0-a917-6f93e48e1e7e.jpg'
Dec 30 02:16:21 volumio volumio[8607]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%8E%E6%98%8E/%E5%A6%82%E6%9E%9C%E5%8F%AF%E4%BB%A5%E5%86%8D%E8%A7%81%E4%BD%A0/d32b5ce7-3c3b-45ad-b5ce-0252dded685b.jpg'
Dec 30 02:16:28 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::stPlaybackTimer
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::updateTrackBlock
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrackBlock
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::serviceStop
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: ControllerMpd::stop
Dec 30 02:16:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand stop
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:16:28 volumio volumio[8607]: info:
Dec 30 02:16:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:28 volumio volumio[8607]: info: sendMpdCommand stop took 5 milliseconds
Dec 30 02:16:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:28 volumio volumio[8607]: info:
Dec 30 02:16:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:28 volumio volumio[8607]: info:
Dec 30 02:16:28 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:28 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:28 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:28 volumio volumio[8607]: info:
Dec 30 02:16:28 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:28 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:28 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:28 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:28 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:28 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: No code
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: No code
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 30 02:16:28 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::syncState stateService stop
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: No code
Dec 30 02:16:28 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:28 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:28 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:28 volumio volumio[8607]: info: ------------------------------ 10ms
Dec 30 02:16:28 volumio volumio[8607]: info: ------------------------------ 10ms
Dec 30 02:16:28 volumio volumio[8607]: info: ------------------------------ 10ms
Dec 30 02:16:28 volumio volumio[8607]: info:
Dec 30 02:16:28 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:28 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:28 volumio volumio[8607]: info:
Dec 30 02:16:28 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:28 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:28 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:28 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:28 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:28 volumio volumio[8607]: info: ------------------------------ 11ms
Dec 30 02:16:28 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:28 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:28 volumio volumio[8607]: info: Clearing queue after UPNP request
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::ClearQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::stop
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::clearPlayQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::saveQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushQueue
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:29 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: error: updateQueue error: null
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: Starting UPNP Playback
Dec 30 02:16:29 volumio volumio[8607]: info: Preparing playback through UPNP
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetState
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getTrack 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 0ms
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蓝色街灯","artist":"黎明","album":"天地情缘","uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus stop
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 0 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蓝色街灯","artist":"黎明","album":"天地情缘","uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:29 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蓝色街灯","artist":"黎明","album":"天地情缘","uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:29 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蓝色街灯","artist":"黎明","album":"天地情缘","uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:29 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蓝色街灯","artist":"黎明","album":"天地情缘","uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:29 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 13ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 12ms
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 11 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蓝色街灯","artist":"黎明","album":"天地情缘","uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:29 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 17ms
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioGetQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info: CorePlayQueue::getQueue
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces system playlist update
Dec 30 02:16:29 volumio volumio[8607]: info: Ignoring MPD Status Update
Dec 30 02:16:29 volumio volumio[8607]: info:
Dec 30 02:16:29 volumio volumio[8607]: ---------------------------- MPD announces state update: player
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::getState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand status
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 11ms
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 11 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 1ms
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand status took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseState
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: verbose: ControllerMpd::parseTrackInfo
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","artist":null,"album":null,"uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:29 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","artist":null,"album":null,"uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:29 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: ControllerMpd::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::servicePushState
Dec 30 02:16:29 volumio volumio[8607]: verbose: In UPNP mode
Dec 30 02:16:29 volumio volumio[8607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":615,"duration":319,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","artist":null,"album":null,"uri":"http://m8.music.126.net/20251230104128/aea15d45e96b1356267f57590a27027f/ymusic/fd85/fe63/68dd/f2929f18b7f4367e20568945274407ec.mp3?vuutv=b07NKBaQlL4Zq9FShn7pb92xOlivEGt74mm0GeaDp5f2SADBp6z77PF1FKbE8QtrUoiQeM/L67/CNCovta9LzqQppKBkPJpaSd7M6YUdrWA=","trackType":""}
Dec 30 02:16:29 volumio volumio[8607]: verbose: CURRENT POSITION 0
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState stateService play
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::syncState currentStatus play
Dec 30 02:16:29 volumio volumio[8607]: info: Received an update from plugin. extracting info from payload
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreStateMachine::pushState
Dec 30 02:16:29 volumio volumio[8607]: info: CoreCommandRouter::volumioPushState
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 21ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 11ms
Dec 30 02:16:29 volumio volumio[8607]: info: ------------------------------ 11ms
Dec 30 02:16:57 volumio volumio[8607]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 30 02:16:57 volumio volumio[8607]: Error: connect ETIMEDOUT 80.87.199.46:443
Dec 30 02:16:57 volumio volumio[8607]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Dec 30 02:16:57 volumio volumio[8607]: errno: -110,
Dec 30 02:16:57 volumio volumio[8607]: code: 'ETIMEDOUT',
Dec 30 02:16:57 volumio volumio[8607]: syscall: 'connect',
Dec 30 02:16:57 volumio volumio[8607]: address: '80.87.199.46',
Dec 30 02:16:57 volumio volumio[8607]: port: 443
Dec 30 02:16:57 volumio volumio[8607]: }
Dec 30 02:16:57 volumio volumio[8607]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 30 02:16:57 volumio sudo[10103]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-30 02:15'
Dec 30 02:16:57 volumio sudo[10103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"