-- Logs begin at Thu 2025-02-20 16:00:32 UTC, end at Thu 2025-02-20 16:07:40 UTC. -- Feb 20 16:06:02 volumio volumio[5019]: info: Feb 20 16:06:02 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:02 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:02 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:02 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:02 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:02 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:02 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:02 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:02 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:02 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":64,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"254 Kbps","isStreaming":false,"title":"1740039411.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039411.ts?wsApp=HLS","trackType":""} Feb 20 16:06:02 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:02 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:02 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:02 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:02 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:02 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:02 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:02 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:02 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:02 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:02 volumio volumio[5019]: info: ------------------------------ 23ms Feb 20 16:06:05 volumio volumio[5019]: info: Feb 20 16:06:05 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:05 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:05 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:05 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:05 volumio volumio[5019]: 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} Feb 20 16:06:05 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:05 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:06:05 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:05 volumio volumio[5019]: info: [1740067565328] ControllerWebradio::clearAddPlayTrack Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:06:05 volumio volumio[5019]: info: ------------------------------ 20ms Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:06:05 volumio volumio[5019]: info: Feb 20 16:06:05 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:05 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:06:05 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:06:05 volumio volumio[5019]: info: ------------------------------ 3ms Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:06:05 volumio volumio[5019]: info: Feb 20 16:06:05 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:05 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:05 volumio volumio[5019]: info: ------------------------------ 2ms Feb 20 16:06:05 volumio volumio[5019]: info: Feb 20 16:06:05 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:05 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:05 volumio volumio[5019]: info: Feb 20 16:06:05 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:05 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:05 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:05 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:05 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"237 Kbps","isStreaming":false,"title":"1740039411.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039411.ts?wsApp=HLS","trackType":""} Feb 20 16:06:05 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:05 volumio volumio[5019]: info: ------------------------------ 43ms Feb 20 16:06:05 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:05 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:05 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:05 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":288,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"261 Kbps","isStreaming":false,"title":"1740039411.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039411.ts?wsApp=HLS","trackType":""} Feb 20 16:06:05 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:05 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:05 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:05 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:05 volumio volumio[5019]: info: ------------------------------ 32ms Feb 20 16:06:08 volumio volumio[5019]: info: Feb 20 16:06:08 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:08 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:08 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:08 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:08 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:08 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:08 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:08 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:08 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:08 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"251 Kbps","isStreaming":false,"title":"1740039412.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039412.ts?wsApp=HLS","trackType":""} Feb 20 16:06:08 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:08 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:08 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:08 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:08 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:08 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:08 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:08 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:08 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:08 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:08 volumio volumio[5019]: info: ------------------------------ 25ms Feb 20 16:06:11 volumio volumio[5019]: info: Feb 20 16:06:11 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:11 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:11 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:11 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:11 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:11 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:11 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:11 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:11 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:11 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"250 Kbps","isStreaming":false,"title":"1740039413.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039413.ts?wsApp=HLS","trackType":""} Feb 20 16:06:11 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:11 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:11 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:11 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:11 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:11 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:11 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:11 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:11 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:11 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:11 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:06:14 volumio volumio[5019]: info: Feb 20 16:06:14 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:14 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:14 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:14 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:14 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:14 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:14 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:14 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:14 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:14 volumio volumio[5019]: 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} Feb 20 16:06:14 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:14 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:14 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:14 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:14 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:06:14 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:14 volumio volumio[5019]: info: [1740067574884] ControllerWebradio::clearAddPlayTrack Feb 20 16:06:14 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:06:14 volumio volumio[5019]: info: ------------------------------ 24ms Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:14 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:14 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:14 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:14 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:06:14 volumio volumio[5019]: info: Feb 20 16:06:14 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:14 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:14 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:06:14 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:06:14 volumio volumio[5019]: info: ------------------------------ 3ms Feb 20 16:06:14 volumio volumio[5019]: info: Feb 20 16:06:14 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:14 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:14 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:06:14 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:06:14 volumio volumio[5019]: info: ------------------------------ 4ms Feb 20 16:06:15 volumio volumio[5019]: info: Feb 20 16:06:15 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:15 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:15 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:15 volumio volumio[5019]: info: Feb 20 16:06:15 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:15 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:15 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:15 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:15 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:15 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:15 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:15 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:15 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:15 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:15 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:15 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"264 Kbps","isStreaming":false,"title":"1740039414.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039414.ts?wsApp=HLS","trackType":""} Feb 20 16:06:15 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:15 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:15 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:06:15 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:15 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:15 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:15 volumio volumio[5019]: info: ------------------------------ 46ms Feb 20 16:06:15 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:15 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:15 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:15 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:15 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"308 Kbps","isStreaming":false,"title":"1740039414.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039414.ts?wsApp=HLS","trackType":""} Feb 20 16:06:15 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:15 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:15 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:15 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:15 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:15 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:15 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:15 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:15 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:15 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:15 volumio volumio[5019]: info: ------------------------------ 32ms Feb 20 16:06:17 volumio volumio[5019]: info: Feb 20 16:06:17 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:17 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:17 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:17 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:17 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:17 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:17 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:17 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:17 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:17 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"240 Kbps","isStreaming":false,"title":"1740039415.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039415.ts?wsApp=HLS","trackType":""} Feb 20 16:06:17 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:17 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:17 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:17 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:17 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:17 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:17 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:17 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:17 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:17 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:17 volumio volumio[5019]: info: ------------------------------ 39ms Feb 20 16:06:20 volumio volumio[5019]: info: Feb 20 16:06:20 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:20 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:20 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:20 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:20 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:20 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:20 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:20 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:20 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:20 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"253 Kbps","isStreaming":false,"title":"1740039416.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039416.ts?wsApp=HLS","trackType":""} Feb 20 16:06:20 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:20 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:20 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:20 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:20 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:20 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:20 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:20 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:20 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:20 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:20 volumio volumio[5019]: info: ------------------------------ 23ms Feb 20 16:06:24 volumio volumio[5019]: info: Feb 20 16:06:24 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:24 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:24 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:24 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:24 volumio volumio[5019]: 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} Feb 20 16:06:24 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:24 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:24 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:06:24 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:24 volumio volumio[5019]: info: [1740067584368] ControllerWebradio::clearAddPlayTrack Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:06:24 volumio volumio[5019]: info: ------------------------------ 20ms Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:24 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:06:24 volumio volumio[5019]: info: Feb 20 16:06:24 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:24 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:06:24 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:06:24 volumio volumio[5019]: info: ------------------------------ 4ms Feb 20 16:06:24 volumio volumio[5019]: info: Feb 20 16:06:24 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:24 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:06:24 volumio volumio[5019]: info: ------------------------------ 4ms Feb 20 16:06:24 volumio volumio[5019]: info: Feb 20 16:06:24 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:24 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:24 volumio volumio[5019]: info: Feb 20 16:06:24 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:24 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:24 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:24 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:24 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"1740039418.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039418.ts?wsApp=HLS","trackType":""} Feb 20 16:06:24 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:24 volumio volumio[5019]: info: ------------------------------ 54ms Feb 20 16:06:24 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:24 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:24 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:24 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:24 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":480,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"275 Kbps","isStreaming":false,"title":"1740039418.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039418.ts?wsApp=HLS","trackType":""} Feb 20 16:06:24 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:24 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:24 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:25 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:25 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:25 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:25 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:25 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:25 volumio volumio[5019]: info: ------------------------------ 41ms Feb 20 16:06:28 volumio volumio[5019]: info: Feb 20 16:06:28 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:28 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:28 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:28 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:28 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:28 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:28 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:28 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"246 Kbps","isStreaming":false,"title":"1740039419.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039419.ts?wsApp=HLS","trackType":""} Feb 20 16:06:28 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:28 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:28 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:28 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:28 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:28 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:28 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:28 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:28 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:28 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:28 volumio volumio[5019]: info: ------------------------------ 30ms Feb 20 16:06:31 volumio volumio[5019]: info: Feb 20 16:06:31 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:31 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:31 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:31 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:31 volumio volumio[5019]: 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} Feb 20 16:06:31 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:31 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:06:31 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:31 volumio volumio[5019]: info: [1740067591246] ControllerWebradio::clearAddPlayTrack Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:06:31 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:06:31 volumio volumio[5019]: info: Feb 20 16:06:31 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:31 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:06:31 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:06:31 volumio volumio[5019]: info: ------------------------------ 3ms Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:06:31 volumio volumio[5019]: info: Feb 20 16:06:31 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:31 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:31 volumio volumio[5019]: info: ------------------------------ 2ms Feb 20 16:06:31 volumio volumio[5019]: info: Feb 20 16:06:31 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:31 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:31 volumio volumio[5019]: info: Feb 20 16:06:31 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:31 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:31 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:31 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:31 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"297 Kbps","isStreaming":false,"title":"1740039420.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039420.ts?wsApp=HLS","trackType":""} Feb 20 16:06:31 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:31 volumio volumio[5019]: info: ------------------------------ 37ms Feb 20 16:06:31 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:31 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:31 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:31 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":203,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"250 Kbps","isStreaming":false,"title":"1740039420.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039420.ts?wsApp=HLS","trackType":""} Feb 20 16:06:31 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:31 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:31 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:31 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:31 volumio volumio[5019]: info: ------------------------------ 32ms Feb 20 16:06:34 volumio volumio[5019]: info: Feb 20 16:06:34 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:34 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:34 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:34 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:34 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:34 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:34 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:34 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:34 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:34 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"328 Kbps","isStreaming":false,"title":"1740039421.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039421.ts?wsApp=HLS","trackType":""} Feb 20 16:06:34 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:34 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:34 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:34 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:34 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:34 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:34 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:34 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:34 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:34 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:34 volumio volumio[5019]: info: ------------------------------ 21ms Feb 20 16:06:37 volumio volumio[5019]: info: Feb 20 16:06:37 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:37 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:37 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:37 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:37 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:37 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:37 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:37 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:37 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:37 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":75,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"241 Kbps","isStreaming":false,"title":"1740039422.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039422.ts?wsApp=HLS","trackType":""} Feb 20 16:06:37 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:37 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:37 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:37 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:37 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:37 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:37 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:37 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:37 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:37 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:37 volumio volumio[5019]: info: ------------------------------ 19ms Feb 20 16:06:40 volumio volumio[5019]: info: Feb 20 16:06:40 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:40 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:40 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:40 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:40 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:40 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:40 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:40 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:40 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:40 volumio volumio[5019]: 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} Feb 20 16:06:40 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:40 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:40 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:40 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:40 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:06:40 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:40 volumio volumio[5019]: info: [1740067600767] ControllerWebradio::clearAddPlayTrack Feb 20 16:06:40 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:06:40 volumio volumio[5019]: info: ------------------------------ 19ms Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:40 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:40 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:40 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:40 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:06:40 volumio volumio[5019]: info: Feb 20 16:06:40 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:40 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:40 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:06:40 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:06:40 volumio volumio[5019]: info: ------------------------------ 4ms Feb 20 16:06:40 volumio volumio[5019]: info: Feb 20 16:06:40 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:40 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:40 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:06:40 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:06:40 volumio volumio[5019]: info: ------------------------------ 4ms Feb 20 16:06:41 volumio volumio[5019]: info: Feb 20 16:06:41 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:41 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:41 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:41 volumio volumio[5019]: info: Feb 20 16:06:41 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:41 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:41 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:41 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:41 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:41 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:41 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:41 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:41 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:41 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:41 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:41 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"248 Kbps","isStreaming":false,"title":"1740039422.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039422.ts?wsApp=HLS","trackType":""} Feb 20 16:06:41 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:41 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:41 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:06:41 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:41 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:41 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:41 volumio volumio[5019]: info: ------------------------------ 47ms Feb 20 16:06:41 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:41 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:41 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:41 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:41 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"253 Kbps","isStreaming":false,"title":"1740039422.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039422.ts?wsApp=HLS","trackType":""} Feb 20 16:06:41 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:41 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:41 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:41 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:41 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:41 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:41 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:41 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:41 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:41 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:41 volumio volumio[5019]: info: ------------------------------ 44ms Feb 20 16:06:43 volumio volumio[5019]: info: Feb 20 16:06:43 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:43 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:43 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:43 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:43 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:43 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:43 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:43 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:43 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:43 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"236 Kbps","isStreaming":false,"title":"1740039423.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039423.ts?wsApp=HLS","trackType":""} Feb 20 16:06:43 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:43 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:43 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:43 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:43 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:43 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:43 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:43 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:43 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:43 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:43 volumio volumio[5019]: info: ------------------------------ 28ms Feb 20 16:06:46 volumio volumio[5019]: info: Feb 20 16:06:46 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:46 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:46 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:46 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:46 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:46 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:46 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:46 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:46 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:46 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"258 Kbps","isStreaming":false,"title":"1740039424.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039424.ts?wsApp=HLS","trackType":""} Feb 20 16:06:46 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:46 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:46 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:46 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:46 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:46 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:46 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:46 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:46 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:46 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:46 volumio volumio[5019]: info: ------------------------------ 19ms Feb 20 16:06:50 volumio volumio[5019]: info: Feb 20 16:06:50 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:50 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:50 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:50 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:50 volumio volumio[5019]: 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} Feb 20 16:06:50 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:50 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:06:50 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:50 volumio volumio[5019]: info: [1740067610240] ControllerWebradio::clearAddPlayTrack Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:06:50 volumio volumio[5019]: info: ------------------------------ 20ms Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:06:50 volumio volumio[5019]: info: Feb 20 16:06:50 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:50 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:06:50 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:06:50 volumio volumio[5019]: info: ------------------------------ 4ms Feb 20 16:06:50 volumio volumio[5019]: info: Feb 20 16:06:50 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:50 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:06:50 volumio volumio[5019]: info: ------------------------------ 4ms Feb 20 16:06:50 volumio volumio[5019]: info: Feb 20 16:06:50 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:50 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:50 volumio volumio[5019]: info: Feb 20 16:06:50 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:50 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:50 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:50 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:50 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"246 Kbps","isStreaming":false,"title":"1740039426.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039426.ts?wsApp=HLS","trackType":""} Feb 20 16:06:50 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:50 volumio volumio[5019]: info: ------------------------------ 45ms Feb 20 16:06:50 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:50 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:50 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:50 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":415,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"278 Kbps","isStreaming":false,"title":"1740039426.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039426.ts?wsApp=HLS","trackType":""} Feb 20 16:06:50 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:50 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:50 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:50 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:50 volumio volumio[5019]: info: ------------------------------ 28ms Feb 20 16:06:53 volumio volumio[5019]: info: Feb 20 16:06:53 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:53 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:53 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:53 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:53 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:53 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:53 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:53 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:53 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:53 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"1740039427.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039427.ts?wsApp=HLS","trackType":""} Feb 20 16:06:53 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:53 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:53 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:53 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:53 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:53 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:53 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:53 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:53 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:53 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:53 volumio volumio[5019]: info: ------------------------------ 20ms Feb 20 16:06:56 volumio volumio[5019]: info: Feb 20 16:06:56 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:56 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:56 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:56 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:56 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:06:56 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:06:56 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:56 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:56 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:56 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":42,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"1740039428.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039428.ts?wsApp=HLS","trackType":""} Feb 20 16:06:56 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:56 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:06:56 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:56 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:06:56 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:56 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:56 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:56 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:56 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:56 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:56 volumio volumio[5019]: info: ------------------------------ 22ms Feb 20 16:06:59 volumio volumio[5019]: info: Feb 20 16:06:59 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:06:59 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:06:59 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:06:59 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:06:59 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:06:59 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:59 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:59 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:59 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:59 volumio volumio[5019]: 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} Feb 20 16:06:59 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:59 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:59 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:59 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:59 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:06:59 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:59 volumio volumio[5019]: info: [1740067619822] ControllerWebradio::clearAddPlayTrack Feb 20 16:06:59 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:06:59 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:06:59 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:06:59 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:06:59 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:06:59 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:06:59 volumio volumio[5019]: info: Feb 20 16:06:59 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:59 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:59 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:06:59 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:06:59 volumio volumio[5019]: info: ------------------------------ 2ms Feb 20 16:06:59 volumio volumio[5019]: info: Feb 20 16:06:59 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:06:59 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:06:59 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:06:59 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:06:59 volumio volumio[5019]: info: ------------------------------ 2ms Feb 20 16:07:00 volumio volumio[5019]: info: Feb 20 16:07:00 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:00 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:00 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:00 volumio volumio[5019]: info: Feb 20 16:07:00 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:00 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:00 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:00 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:00 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:00 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:00 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:00 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:00 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:00 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:00 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:00 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"1740039429.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039429.ts?wsApp=HLS","trackType":""} Feb 20 16:07:00 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:00 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:00 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:07:00 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:00 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:00 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:00 volumio volumio[5019]: info: ------------------------------ 40ms Feb 20 16:07:00 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:00 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:00 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:00 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:00 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":245,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"253 Kbps","isStreaming":false,"title":"1740039429.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039429.ts?wsApp=HLS","trackType":""} Feb 20 16:07:00 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:00 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:00 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:00 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:00 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:00 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:00 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:00 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:00 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:00 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:00 volumio volumio[5019]: info: ------------------------------ 29ms Feb 20 16:07:02 volumio volumio[5019]: info: Feb 20 16:07:02 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:02 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:02 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:02 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:02 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:02 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:02 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:02 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:02 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:02 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"259 Kbps","isStreaming":false,"title":"1740039430.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039430.ts?wsApp=HLS","trackType":""} Feb 20 16:07:02 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:02 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:02 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:02 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:02 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:02 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:02 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:02 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:02 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:02 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:02 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:07:05 volumio volumio[5019]: info: Feb 20 16:07:05 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:05 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:05 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:05 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:05 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:05 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:05 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:05 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:05 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"244 Kbps","isStreaming":false,"title":"1740039431.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039431.ts?wsApp=HLS","trackType":""} Feb 20 16:07:05 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:05 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:05 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:05 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:05 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:05 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:05 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:05 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:05 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:05 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:05 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:07:09 volumio volumio[5019]: info: Feb 20 16:07:09 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:09 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:09 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:09 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:09 volumio volumio[5019]: 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} Feb 20 16:07:09 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:09 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:07:09 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:09 volumio volumio[5019]: info: [1740067629342] ControllerWebradio::clearAddPlayTrack Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:07:09 volumio volumio[5019]: info: ------------------------------ 34ms Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:07:09 volumio volumio[5019]: info: Feb 20 16:07:09 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:07:09 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:07:09 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:07:09 volumio volumio[5019]: info: ------------------------------ 2ms Feb 20 16:07:09 volumio volumio[5019]: info: Feb 20 16:07:09 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:07:09 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:07:09 volumio volumio[5019]: info: ------------------------------ 12ms Feb 20 16:07:09 volumio volumio[5019]: info: Feb 20 16:07:09 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:09 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:09 volumio volumio[5019]: info: Feb 20 16:07:09 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:09 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:09 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:09 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:09 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"259 Kbps","isStreaming":false,"title":"1740039432.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039432.ts?wsApp=HLS","trackType":""} Feb 20 16:07:09 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:09 volumio volumio[5019]: info: ------------------------------ 41ms Feb 20 16:07:09 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:09 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:09 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:09 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":255,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"258 Kbps","isStreaming":false,"title":"1740039432.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039432.ts?wsApp=HLS","trackType":""} Feb 20 16:07:09 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:09 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:09 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:09 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:09 volumio volumio[5019]: info: ------------------------------ 39ms Feb 20 16:07:12 volumio volumio[5019]: info: Feb 20 16:07:12 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:12 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:12 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:12 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:12 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:12 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:12 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:12 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:12 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:12 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"249 Kbps","isStreaming":false,"title":"1740039433.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039433.ts?wsApp=HLS","trackType":""} Feb 20 16:07:12 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:12 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:12 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:12 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:12 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:12 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:12 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:12 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:12 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:12 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:12 volumio volumio[5019]: info: ------------------------------ 17ms Feb 20 16:07:15 volumio volumio[5019]: info: Feb 20 16:07:15 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:15 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:15 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:15 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:15 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:15 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:15 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:15 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:15 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:15 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"241 Kbps","isStreaming":false,"title":"1740039434.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039434.ts?wsApp=HLS","trackType":""} Feb 20 16:07:15 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:15 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:15 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:15 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:15 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:15 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:15 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:15 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:15 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:15 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:15 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:07:18 volumio volumio[5019]: info: Feb 20 16:07:18 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:18 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:18 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:18 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:18 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:18 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:18 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:18 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:18 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:18 volumio volumio[5019]: 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} Feb 20 16:07:18 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:18 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:18 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:18 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:18 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:07:18 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:18 volumio volumio[5019]: info: [1740067638880] ControllerWebradio::clearAddPlayTrack Feb 20 16:07:18 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:07:18 volumio volumio[5019]: info: ------------------------------ 19ms Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:18 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:18 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:18 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:18 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:07:18 volumio volumio[5019]: info: Feb 20 16:07:18 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:07:18 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:07:18 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:07:18 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:07:18 volumio volumio[5019]: info: ------------------------------ 2ms Feb 20 16:07:18 volumio volumio[5019]: info: Feb 20 16:07:18 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:07:18 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:07:18 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:07:18 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:07:18 volumio volumio[5019]: info: ------------------------------ 4ms Feb 20 16:07:19 volumio volumio[5019]: info: Feb 20 16:07:19 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:19 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:19 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:19 volumio volumio[5019]: info: Feb 20 16:07:19 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:19 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:19 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:19 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:19 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:19 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:19 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:19 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:19 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:19 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:19 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:19 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"254 Kbps","isStreaming":false,"title":"1740039435.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039435.ts?wsApp=HLS","trackType":""} Feb 20 16:07:19 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:19 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:19 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:07:19 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:19 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:19 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:19 volumio volumio[5019]: info: ------------------------------ 49ms Feb 20 16:07:19 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:19 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:19 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:19 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:19 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"247 Kbps","isStreaming":false,"title":"1740039435.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039435.ts?wsApp=HLS","trackType":""} Feb 20 16:07:19 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:19 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:19 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:19 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:19 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:19 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:19 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:19 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:19 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:19 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:19 volumio volumio[5019]: info: ------------------------------ 36ms Feb 20 16:07:21 volumio volumio[5019]: info: Feb 20 16:07:21 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:21 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:21 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:21 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:21 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:21 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:21 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:21 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:21 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:21 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"1740039436.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039436.ts?wsApp=HLS","trackType":""} Feb 20 16:07:21 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:21 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:21 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:21 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:21 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:21 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:21 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:21 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:21 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:21 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:21 volumio volumio[5019]: info: ------------------------------ 17ms Feb 20 16:07:24 volumio volumio[5019]: info: Feb 20 16:07:24 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:24 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:24 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:24 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:24 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:24 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:24 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:24 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:24 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"1740039437.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039437.ts?wsApp=HLS","trackType":""} Feb 20 16:07:24 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:24 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:24 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:24 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:24 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:24 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:24 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:24 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:24 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:24 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:24 volumio volumio[5019]: info: ------------------------------ 38ms Feb 20 16:07:28 volumio volumio[5019]: info: Feb 20 16:07:28 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:28 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:28 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:28 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:28 volumio volumio[5019]: 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} Feb 20 16:07:28 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:28 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:07:28 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:28 volumio volumio[5019]: info: [1740067648399] ControllerWebradio::clearAddPlayTrack Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:07:28 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:07:28 volumio volumio[5019]: info: Feb 20 16:07:28 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:07:28 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:07:28 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:07:28 volumio volumio[5019]: info: ------------------------------ 2ms Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:07:28 volumio volumio[5019]: info: Feb 20 16:07:28 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:07:28 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:07:28 volumio volumio[5019]: info: ------------------------------ 2ms Feb 20 16:07:28 volumio volumio[5019]: info: Feb 20 16:07:28 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:28 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:28 volumio volumio[5019]: info: Feb 20 16:07:28 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:28 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:28 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:28 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:28 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"259 Kbps","isStreaming":false,"title":"1740039438.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039438.ts?wsApp=HLS","trackType":""} Feb 20 16:07:28 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:28 volumio volumio[5019]: info: ------------------------------ 41ms Feb 20 16:07:28 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:28 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:28 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:28 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":437,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"328 Kbps","isStreaming":false,"title":"1740039438.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039438.ts?wsApp=HLS","trackType":""} Feb 20 16:07:28 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:28 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:28 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:28 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:28 volumio volumio[5019]: info: ------------------------------ 30ms Feb 20 16:07:31 volumio volumio[5019]: info: Feb 20 16:07:31 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:31 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:31 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:31 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:31 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:31 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:31 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:31 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:31 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":1,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"249 Kbps","isStreaming":false,"title":"1740039439.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039439.ts?wsApp=HLS","trackType":""} Feb 20 16:07:31 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:31 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:31 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:31 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:31 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:31 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:31 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:31 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:31 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:31 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:31 volumio volumio[5019]: info: ------------------------------ 19ms Feb 20 16:07:34 volumio volumio[5019]: info: Feb 20 16:07:34 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:34 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:34 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:34 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:34 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:34 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:34 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:34 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:34 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:34 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":2,"seek":95,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"1740039440.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039440.ts?wsApp=HLS","trackType":""} Feb 20 16:07:34 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:34 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:34 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:34 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:34 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:34 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:34 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:34 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:34 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:34 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:34 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:07:37 volumio volumio[5019]: info: Feb 20 16:07:37 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:37 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:37 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:37 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:37 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:37 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:37 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:37 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:37 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:37 volumio volumio[5019]: 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} Feb 20 16:07:37 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::syncState stateService stop Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::play index undefined Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:37 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:37 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:37 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:37 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::startPlaybackTimer Feb 20 16:07:37 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:37 volumio volumio[5019]: info: [1740067657886] ControllerWebradio::clearAddPlayTrack Feb 20 16:07:37 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 16:07:37 volumio volumio[5019]: info: ------------------------------ 18ms Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:37 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:37 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:37 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:37 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 16:07:37 volumio volumio[5019]: info: Feb 20 16:07:37 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:07:37 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:07:37 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 16:07:37 volumio volumio[5019]: error: updateQueue error: null Feb 20 16:07:37 volumio volumio[5019]: info: ------------------------------ 3ms Feb 20 16:07:37 volumio volumio[5019]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 16:07:37 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand play Feb 20 16:07:37 volumio volumio[5019]: info: Feb 20 16:07:37 volumio volumio[5019]: ---------------------------- MPD announces system playlist update Feb 20 16:07:37 volumio volumio[5019]: info: Ignoring MPD Status Update Feb 20 16:07:37 volumio volumio[5019]: info: ------------------------------ 1ms Feb 20 16:07:38 volumio volumio[5019]: info: Feb 20 16:07:38 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:38 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:38 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:38 volumio volumio[5019]: info: Feb 20 16:07:38 volumio volumio[5019]: ---------------------------- MPD announces state update: player Feb 20 16:07:38 volumio volumio[5019]: info: ControllerMpd::getState Feb 20 16:07:38 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand status Feb 20 16:07:38 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:38 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:38 volumio volumio[5019]: verbose: ControllerMpd::parseState Feb 20 16:07:38 volumio volumio[5019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 16:07:38 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:38 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:38 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:38 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:38 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"297 Kbps","isStreaming":false,"title":"1740039442.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039442.ts?wsApp=HLS","trackType":""} Feb 20 16:07:38 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:38 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:38 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus stop Feb 20 16:07:38 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:38 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:38 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:38 volumio volumio[5019]: info: ------------------------------ 38ms Feb 20 16:07:38 volumio volumio[5019]: verbose: ControllerMpd::parseTrackInfo Feb 20 16:07:38 volumio volumio[5019]: info: ControllerMpd::pushState Feb 20 16:07:38 volumio volumio[5019]: info: CoreCommandRouter::servicePushState Feb 20 16:07:38 volumio volumio[5019]: info: CorePlayQueue::getTrack 0 Feb 20 16:07:38 volumio volumio[5019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"1740039442.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740039442.ts?wsApp=HLS","trackType":""} Feb 20 16:07:38 volumio volumio[5019]: verbose: CURRENT POSITION 0 Feb 20 16:07:38 volumio volumio[5019]: info: CoreStateMachine::syncState stateService play Feb 20 16:07:38 volumio volumio[5019]: info: CoreStateMachine::syncState currentStatus play Feb 20 16:07:38 volumio volumio[5019]: info: Received an update from plugin. extracting info from payload Feb 20 16:07:38 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:38 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:38 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:38 volumio volumio[5019]: info: CoreStateMachine::pushState Feb 20 16:07:38 volumio volumio[5019]: info: CoreCommandRouter::volumioPushState Feb 20 16:07:38 volumio volumio[5019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 16:07:38 volumio volumio[5019]: info: ------------------------------ 32ms Feb 20 16:07:39 volumio volumio[5019]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 20 16:07:39 volumio volumio[5019]: { Error: connect ETIMEDOUT 104.16.251.55:80 Feb 20 16:07:39 volumio volumio[5019]: at Object._errnoException (util.js:1022:11) Feb 20 16:07:39 volumio volumio[5019]: at _exceptionWithHostPort (util.js:1044:20) Feb 20 16:07:39 volumio volumio[5019]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Feb 20 16:07:39 volumio volumio[5019]: code: 'ETIMEDOUT', Feb 20 16:07:39 volumio volumio[5019]: errno: 'ETIMEDOUT', Feb 20 16:07:39 volumio volumio[5019]: syscall: 'connect', Feb 20 16:07:39 volumio volumio[5019]: address: '104.16.251.55', Feb 20 16:07:39 volumio volumio[5019]: port: 80 } Feb 20 16:07:39 volumio volumio[5019]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 20 16:07:40 volumio sudo[6461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-20 16:06 Feb 20 16:07:40 volumio sudo[6461]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"