-- Logs begin at Thu 2025-02-20 13:50:52 UTC, end at Thu 2025-02-20 13:54:30 UTC. -- Feb 20 13:53:06 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 20 13:53:08 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::ClearQueue Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::stop Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:14 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::stPlaybackTimer Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::updateTrackBlock Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::getTrackBlock Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::serviceStop Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::serviceStop Feb 20 13:53:14 volumio volumio[4893]: info: ControllerMpd::stop Feb 20 13:53:14 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::clearPlayQueue Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::saveQueue Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::volumioPushQueue Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::addQueueItems Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::addQueueItems Feb 20 13:53:14 volumio volumio[4893]: info: Adding Item to queue: http://satellitepull.cnr.cn/live/wxzj968/playlist.m3u8 Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::saveQueue Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::volumioPushQueue Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::updateTrackBlock Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::getTrackBlock Feb 20 13:53:14 volumio volumio[4893]: info: CoreCommandRouter::volumioPlay Feb 20 13:53:14 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::play index 0 Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::stop Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:14 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:14 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:53:14 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:14 volumio volumio[4893]: info: [1740059594628] ControllerWebradio::clearAddPlayTrack Feb 20 13:53:14 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:14 volumio volumio[4893]: info: Feb 20 13:53:14 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:14 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:14 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:14 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:53:14 volumio volumio[4893]: info: Feb 20 13:53:14 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:14 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:14 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:14 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:14 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "http://satellitepull.cnr.cn/live/wxzj968/playlist.m3u8" Feb 20 13:53:14 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:53:14 volumio volumio[4893]: info: ------------------------------ 8ms Feb 20 13:53:14 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:14 volumio volumio[4893]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 20 13:53:14 volumio volumio[4893]: info: ------------------------------ 19ms Feb 20 13:53:15 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:53:15 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:53:15 volumio volumio[4893]: info: Feb 20 13:53:15 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:15 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:15 volumio volumio[4893]: info: ------------------------------ 3ms Feb 20 13:53:17 volumio volumio[4893]: info: Feb 20 13:53:17 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:17 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:17 volumio volumio[4893]: info: Feb 20 13:53:17 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:17 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:17 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:17 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:17 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:17 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:17 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:17 volumio volumio[4893]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"217 Kbps","isStreaming":false,"title":"playlist.m3u8?wsSession=1fd0561142f7bce3c60c9f47-174005959478465&wsIPSercert=ef0baadaf61a5ad365f828d8a2bb8cc6","artist":null,"album":null,"uri":"http://satellitepull.cnr.cn/live/wxzj968/playlist.m3u8?wsSession=1fd0561142f7bce3c60c9f47-174005959478465&wsIPSercert=ef0baadaf61a5ad365f828d8a2bb8cc6","trackType":""} Feb 20 13:53:17 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:17 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:17 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:53:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:17 volumio volumio[4893]: info: ------------------------------ 91ms Feb 20 13:53:17 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:17 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:17 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:17 volumio volumio[4893]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"217 Kbps","isStreaming":false,"title":"playlist.m3u8?wsSession=1fd0561142f7bce3c60c9f47-174005959478465&wsIPSercert=ef0baadaf61a5ad365f828d8a2bb8cc6","artist":null,"album":null,"uri":"http://satellitepull.cnr.cn/live/wxzj968/playlist.m3u8?wsSession=1fd0561142f7bce3c60c9f47-174005959478465&wsIPSercert=ef0baadaf61a5ad365f828d8a2bb8cc6","trackType":""} Feb 20 13:53:17 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:17 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:17 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:17 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:17 volumio volumio[4893]: info: ------------------------------ 54ms Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::ClearQueue Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::stop Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:24 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::stPlaybackTimer Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::updateTrackBlock Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::getTrackBlock Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::serviceStop Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::serviceStop Feb 20 13:53:24 volumio volumio[4893]: info: [1740059604889] ControllerWebradio::stop Feb 20 13:53:24 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::clearPlayQueue Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::saveQueue Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::volumioPushQueue Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::addQueueItems Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::addQueueItems Feb 20 13:53:24 volumio volumio[4893]: info: Adding Item to queue: https://sk.cri.cn/887.m3u8 Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::saveQueue Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::volumioPushQueue Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::updateTrackBlock Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::getTrackBlock Feb 20 13:53:24 volumio volumio[4893]: info: CoreCommandRouter::volumioPlay Feb 20 13:53:24 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::play index 0 Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::stop Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:24 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:24 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:53:24 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:24 volumio volumio[4893]: info: [1740059604917] ControllerWebradio::clearAddPlayTrack Feb 20 13:53:24 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:26 volumio volumio[4893]: info: Feb 20 13:53:26 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:26 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:53:26 volumio volumio[4893]: info: Feb 20 13:53:26 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:26 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:26 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/887.m3u8" Feb 20 13:53:26 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:53:26 volumio volumio[4893]: info: ------------------------------ 10ms Feb 20 13:53:26 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:26 volumio volumio[4893]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 20 13:53:26 volumio volumio[4893]: info: ------------------------------ 21ms Feb 20 13:53:26 volumio volumio[4893]: info: Feb 20 13:53:26 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:26 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:26 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:53:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:53:26 volumio volumio[4893]: info: ------------------------------ 6ms Feb 20 13:53:27 volumio volumio[4893]: info: Feb 20 13:53:27 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:27 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:27 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:27 volumio volumio[4893]: info: Feb 20 13:53:27 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:27 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:27 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:27 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:27 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:27 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:27 volumio volumio[4893]: 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":"258 Kbps","isStreaming":false,"title":"1739904114.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904114.ts?wsApp=HLS","trackType":""} Feb 20 13:53:27 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:27 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:27 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:53:27 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:27 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:27 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:27 volumio volumio[4893]: info: ------------------------------ 55ms Feb 20 13:53:27 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:27 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:27 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:27 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:27 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:27 volumio volumio[4893]: 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":"254 Kbps","isStreaming":false,"title":"1739904114.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904114.ts?wsApp=HLS","trackType":""} Feb 20 13:53:27 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:27 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:27 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:27 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:27 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:27 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:27 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:27 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:27 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:27 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:27 volumio volumio[4893]: info: ------------------------------ 48ms Feb 20 13:53:29 volumio volumio[4893]: info: Feb 20 13:53:29 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:29 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:29 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:29 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:29 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:29 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:29 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:29 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:29 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:29 volumio volumio[4893]: 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":"248 Kbps","isStreaming":false,"title":"1739904115.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904115.ts?wsApp=HLS","trackType":""} Feb 20 13:53:29 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:29 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:29 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:29 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:29 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:29 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:29 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:29 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:29 volumio volumio[4893]: info: ------------------------------ 24ms Feb 20 13:53:33 volumio volumio[4893]: info: Feb 20 13:53:33 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:33 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:33 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:33 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:33 volumio volumio[4893]: 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 13:53:33 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::syncState stateService stop Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:33 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:53:33 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:33 volumio volumio[4893]: info: [1740059613502] ControllerWebradio::clearAddPlayTrack Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:33 volumio volumio[4893]: info: ------------------------------ 29ms Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:53:33 volumio volumio[4893]: info: Feb 20 13:53:33 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:33 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/887.m3u8" Feb 20 13:53:33 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:53:33 volumio volumio[4893]: info: ------------------------------ 5ms Feb 20 13:53:33 volumio volumio[4893]: info: Feb 20 13:53:33 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:33 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:53:33 volumio volumio[4893]: info: ------------------------------ 5ms Feb 20 13:53:33 volumio volumio[4893]: info: Feb 20 13:53:33 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:33 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:33 volumio volumio[4893]: info: Feb 20 13:53:33 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:33 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:33 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:33 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:33 volumio volumio[4893]: 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":"289 Kbps","isStreaming":false,"title":"1739904116.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904116.ts?wsApp=HLS","trackType":""} Feb 20 13:53:33 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:33 volumio volumio[4893]: info: ------------------------------ 43ms Feb 20 13:53:33 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:33 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:33 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:33 volumio volumio[4893]: 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":"1739904116.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904116.ts?wsApp=HLS","trackType":""} Feb 20 13:53:33 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:33 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:33 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:33 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:33 volumio volumio[4893]: info: ------------------------------ 51ms Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::ClearQueue Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::stop Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:35 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::stPlaybackTimer Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::updateTrackBlock Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::getTrackBlock Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::serviceStop Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::serviceStop Feb 20 13:53:35 volumio volumio[4893]: info: [1740059615201] ControllerWebradio::stop Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::clearPlayQueue Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::saveQueue Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::volumioPushQueue Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::addQueueItems Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::addQueueItems Feb 20 13:53:35 volumio volumio[4893]: info: Adding Item to queue: https://sk.cri.cn/915.m3u8 Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::saveQueue Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::volumioPushQueue Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::updateTrackBlock Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::getTrackBlock Feb 20 13:53:35 volumio volumio[4893]: info: CoreCommandRouter::volumioPlay Feb 20 13:53:35 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::play index 0 Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::stop Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:35 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:53:35 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:35 volumio volumio[4893]: info: [1740059615229] ControllerWebradio::clearAddPlayTrack Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:35 volumio volumio[4893]: info: Feb 20 13:53:35 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:35 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:53:35 volumio volumio[4893]: info: Feb 20 13:53:35 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:35 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 13:53:35 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:53:35 volumio volumio[4893]: info: ------------------------------ 7ms Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:35 volumio volumio[4893]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 20 13:53:35 volumio volumio[4893]: info: ------------------------------ 14ms Feb 20 13:53:35 volumio volumio[4893]: info: Feb 20 13:53:35 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:35 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:35 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:53:35 volumio volumio[4893]: info: ------------------------------ 4ms Feb 20 13:53:35 volumio volumio[4893]: info: Feb 20 13:53:35 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:35 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:35 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:36 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:36 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:36 volumio volumio[4893]: info: Feb 20 13:53:36 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:36 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:36 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:36 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:36 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:36 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:36 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:36 volumio volumio[4893]: 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":"259 Kbps","isStreaming":false,"title":"1740036770.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036770.ts?wsApp=HLS","trackType":""} Feb 20 13:53:36 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:36 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:36 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:53:36 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:36 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:36 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:36 volumio volumio[4893]: info: ------------------------------ 63ms Feb 20 13:53:36 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:36 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:36 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:36 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:36 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:36 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:36 volumio volumio[4893]: 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":"256 Kbps","isStreaming":false,"title":"1740036770.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036770.ts?wsApp=HLS","trackType":""} Feb 20 13:53:36 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:36 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:36 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:36 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:36 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:36 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:36 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:36 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:36 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:36 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:36 volumio volumio[4893]: info: ------------------------------ 65ms Feb 20 13:53:38 volumio volumio[4893]: info: Feb 20 13:53:38 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:38 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:39 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:39 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:39 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:39 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:39 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:39 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:39 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:39 volumio volumio[4893]: verbose: STATE SERVICE {"status":"play","position":2,"seek":458,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"264 Kbps","isStreaming":false,"title":"1740036771.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036771.ts?wsApp=HLS","trackType":""} Feb 20 13:53:39 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:39 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:39 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:39 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:39 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:39 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:39 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:39 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:39 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:39 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:39 volumio volumio[4893]: info: ------------------------------ 31ms Feb 20 13:53:42 volumio volumio[4893]: info: Feb 20 13:53:42 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:42 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:42 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:42 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:42 volumio volumio[4893]: 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 13:53:42 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::syncState stateService stop Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:42 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:53:42 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:42 volumio volumio[4893]: info: [1740059622190] ControllerWebradio::clearAddPlayTrack Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:42 volumio volumio[4893]: info: ------------------------------ 28ms Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:53:42 volumio volumio[4893]: info: Feb 20 13:53:42 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:42 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 13:53:42 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:53:42 volumio volumio[4893]: info: ------------------------------ 5ms Feb 20 13:53:42 volumio volumio[4893]: info: Feb 20 13:53:42 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:42 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:53:42 volumio volumio[4893]: info: ------------------------------ 5ms Feb 20 13:53:42 volumio volumio[4893]: info: Feb 20 13:53:42 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:42 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:42 volumio volumio[4893]: info: Feb 20 13:53:42 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:42 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:42 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:42 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:42 volumio volumio[4893]: 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":"1740036771.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036771.ts?wsApp=HLS","trackType":""} Feb 20 13:53:42 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:42 volumio volumio[4893]: info: ------------------------------ 41ms Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:42 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:42 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:42 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:42 volumio volumio[4893]: 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":"258 Kbps","isStreaming":false,"title":"1740036771.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036771.ts?wsApp=HLS","trackType":""} Feb 20 13:53:42 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:42 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:42 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:42 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:42 volumio volumio[4893]: info: ------------------------------ 41ms Feb 20 13:53:45 volumio volumio[4893]: info: Feb 20 13:53:45 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:45 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:45 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:45 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:45 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:45 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:45 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:45 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:45 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:45 volumio volumio[4893]: 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":"252 Kbps","isStreaming":false,"title":"1740036772.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036772.ts?wsApp=HLS","trackType":""} Feb 20 13:53:45 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:45 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:45 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:45 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:45 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:45 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:45 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:45 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:45 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:45 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:45 volumio volumio[4893]: info: ------------------------------ 28ms Feb 20 13:53:48 volumio volumio[4893]: info: Feb 20 13:53:48 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:48 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:48 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:48 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:48 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:48 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:48 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:48 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:48 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:48 volumio volumio[4893]: 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":"1740036773.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036773.ts?wsApp=HLS","trackType":""} Feb 20 13:53:48 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:48 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:48 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:48 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:48 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:48 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:48 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:48 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:48 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:48 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:48 volumio volumio[4893]: info: ------------------------------ 31ms Feb 20 13:53:51 volumio volumio[4893]: info: Feb 20 13:53:51 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:51 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:51 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:51 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:51 volumio volumio[4893]: 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 13:53:51 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::syncState stateService stop Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:51 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:51 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:53:51 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:51 volumio volumio[4893]: info: [1740059631680] ControllerWebradio::clearAddPlayTrack Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:53:51 volumio volumio[4893]: info: ------------------------------ 27ms Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:51 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:53:51 volumio volumio[4893]: info: Feb 20 13:53:51 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:51 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 13:53:51 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:53:51 volumio volumio[4893]: info: ------------------------------ 5ms Feb 20 13:53:51 volumio volumio[4893]: info: Feb 20 13:53:51 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:53:51 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:53:51 volumio volumio[4893]: info: ------------------------------ 5ms Feb 20 13:53:51 volumio volumio[4893]: info: Feb 20 13:53:51 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:51 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:51 volumio volumio[4893]: info: Feb 20 13:53:51 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:51 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:51 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:51 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:51 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:51 volumio volumio[4893]: 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":"256 Kbps","isStreaming":false,"title":"1740036774.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036774.ts?wsApp=HLS","trackType":""} Feb 20 13:53:51 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:53:51 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:51 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:52 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:52 volumio volumio[4893]: info: ------------------------------ 54ms Feb 20 13:53:52 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:52 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:52 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:52 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:52 volumio volumio[4893]: 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":"277 Kbps","isStreaming":false,"title":"1740036774.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036774.ts?wsApp=HLS","trackType":""} Feb 20 13:53:52 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:52 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:52 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:52 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:52 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:52 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:52 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:52 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:52 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:52 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:52 volumio volumio[4893]: info: ------------------------------ 41ms Feb 20 13:53:54 volumio volumio[4893]: info: Feb 20 13:53:54 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:54 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:54 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:54 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:54 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:54 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:54 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:54 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:54 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:54 volumio volumio[4893]: 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":"253 Kbps","isStreaming":false,"title":"1740036775.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036775.ts?wsApp=HLS","trackType":""} Feb 20 13:53:54 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:54 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:54 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:54 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:54 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:54 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:54 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:54 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:54 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:54 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:54 volumio volumio[4893]: info: ------------------------------ 26ms Feb 20 13:53:57 volumio volumio[4893]: info: Feb 20 13:53:57 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:53:57 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:53:57 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:53:57 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:53:57 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:53:57 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:53:57 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:53:57 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:53:57 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:53:57 volumio volumio[4893]: 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":"315 Kbps","isStreaming":false,"title":"1740036776.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036776.ts?wsApp=HLS","trackType":""} Feb 20 13:53:57 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:53:57 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:53:57 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:53:57 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:53:57 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:57 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:57 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:57 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:53:57 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:53:57 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:53:57 volumio volumio[4893]: info: ------------------------------ 38ms Feb 20 13:54:00 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 20 13:54:01 volumio volumio[4893]: info: Feb 20 13:54:01 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:01 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:01 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:01 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:01 volumio volumio[4893]: 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 13:54:01 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::syncState stateService stop Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:01 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:54:01 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:01 volumio volumio[4893]: info: [1740059641163] ControllerWebradio::clearAddPlayTrack Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:54:01 volumio volumio[4893]: info: ------------------------------ 26ms Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:54:01 volumio volumio[4893]: info: Feb 20 13:54:01 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:54:01 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/915.m3u8" Feb 20 13:54:01 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:54:01 volumio volumio[4893]: info: ------------------------------ 4ms Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:54:01 volumio volumio[4893]: info: Feb 20 13:54:01 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:54:01 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:54:01 volumio volumio[4893]: info: ------------------------------ 2ms Feb 20 13:54:01 volumio volumio[4893]: info: Feb 20 13:54:01 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:01 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:01 volumio volumio[4893]: info: Feb 20 13:54:01 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:01 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:01 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:01 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:01 volumio volumio[4893]: 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":"265 Kbps","isStreaming":false,"title":"1740036777.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036777.ts?wsApp=HLS","trackType":""} Feb 20 13:54:01 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:01 volumio volumio[4893]: info: ------------------------------ 43ms Feb 20 13:54:01 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:01 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:01 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:01 volumio volumio[4893]: 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":"258 Kbps","isStreaming":false,"title":"1740036777.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036777.ts?wsApp=HLS","trackType":""} Feb 20 13:54:01 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:01 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:01 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:01 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:01 volumio volumio[4893]: info: ------------------------------ 39ms Feb 20 13:54:04 volumio volumio[4893]: info: Feb 20 13:54:04 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:04 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:04 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:04 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:04 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:04 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:04 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:04 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:04 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:04 volumio volumio[4893]: 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":"1740036778.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036778.ts?wsApp=HLS","trackType":""} Feb 20 13:54:04 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:04 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:04 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:04 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:04 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:04 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:04 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:04 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:04 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:04 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:04 volumio volumio[4893]: info: ------------------------------ 25ms Feb 20 13:54:07 volumio volumio[4893]: info: Feb 20 13:54:07 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:07 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:07 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:07 volumio volumio[4893]: 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":"1740036779.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/915/1740036779.ts?wsApp=HLS","trackType":""} Feb 20 13:54:07 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:07 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:07 volumio volumio[4893]: info: ------------------------------ 23ms Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::ClearQueue Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::stop Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:54:07 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::stPlaybackTimer Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::updateTrackBlock Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::getTrackBlock Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::serviceStop Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::serviceStop Feb 20 13:54:07 volumio volumio[4893]: info: [1740059647747] ControllerWebradio::stop Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::clearPlayQueue Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::saveQueue Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::volumioPushQueue Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::addQueueItems Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::addQueueItems Feb 20 13:54:07 volumio volumio[4893]: info: Adding Item to queue: https://sk.cri.cn/887.m3u8 Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::saveQueue Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::volumioPushQueue Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::updateTrackBlock Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::getTrackBlock Feb 20 13:54:07 volumio volumio[4893]: info: CoreCommandRouter::volumioPlay Feb 20 13:54:07 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::play index 0 Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::stop Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:54:07 volumio volumio[4893]: UNSET VOLATILE Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:54:07 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:07 volumio volumio[4893]: info: [1740059647772] ControllerWebradio::clearAddPlayTrack Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:54:07 volumio volumio[4893]: info: Feb 20 13:54:07 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:07 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:54:07 volumio volumio[4893]: info: Feb 20 13:54:07 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:54:07 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/887.m3u8" Feb 20 13:54:07 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:54:07 volumio volumio[4893]: info: ------------------------------ 8ms Feb 20 13:54:07 volumio volumio[4893]: error: ControllerMpd::pushError: Error: [2@0] {} Bad song index Feb 20 13:54:07 volumio volumio[4893]: info: ------------------------------ 13ms Feb 20 13:54:07 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:54:07 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:54:07 volumio volumio[4893]: info: Feb 20 13:54:07 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:54:07 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:54:07 volumio volumio[4893]: info: ------------------------------ 2ms Feb 20 13:54:08 volumio volumio[4893]: info: Feb 20 13:54:08 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:08 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:08 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:08 volumio volumio[4893]: info: Feb 20 13:54:08 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:08 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:08 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:08 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:08 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:08 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:08 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:08 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:08 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:08 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:08 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:08 volumio volumio[4893]: 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":"241 Kbps","isStreaming":false,"title":"1739904127.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904127.ts?wsApp=HLS","trackType":""} Feb 20 13:54:08 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:08 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:08 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:54:08 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:08 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:08 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:08 volumio volumio[4893]: info: ------------------------------ 41ms Feb 20 13:54:08 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:08 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:08 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:08 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:08 volumio volumio[4893]: 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":"257 Kbps","isStreaming":false,"title":"1739904127.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904127.ts?wsApp=HLS","trackType":""} Feb 20 13:54:08 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:08 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:08 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:08 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:08 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:08 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:08 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:08 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:08 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:08 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:08 volumio volumio[4893]: info: ------------------------------ 38ms Feb 20 13:54:10 volumio volumio[4893]: info: Feb 20 13:54:10 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:10 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:10 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:10 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:10 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:10 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:10 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:10 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:10 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:10 volumio volumio[4893]: 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":"253 Kbps","isStreaming":false,"title":"1739904128.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904128.ts?wsApp=HLS","trackType":""} Feb 20 13:54:10 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:10 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:10 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:10 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:10 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:10 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:10 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:10 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:10 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:10 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:10 volumio volumio[4893]: info: ------------------------------ 30ms Feb 20 13:54:13 volumio volumio[4893]: info: Feb 20 13:54:13 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:13 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:13 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:13 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:13 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:13 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:13 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:13 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:13 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:13 volumio volumio[4893]: 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":"1739904129.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904129.ts?wsApp=HLS","trackType":""} Feb 20 13:54:13 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:13 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:13 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:13 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:13 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:13 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:13 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:13 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:13 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:13 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:13 volumio volumio[4893]: info: ------------------------------ 23ms Feb 20 13:54:17 volumio volumio[4893]: info: Feb 20 13:54:17 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:17 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:17 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:17 volumio volumio[4893]: 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 13:54:17 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::syncState stateService stop Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:54:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:17 volumio volumio[4893]: info: [1740059657309] ControllerWebradio::clearAddPlayTrack Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:54:17 volumio volumio[4893]: info: ------------------------------ 27ms Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:54:17 volumio volumio[4893]: info: Feb 20 13:54:17 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:54:17 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/887.m3u8" Feb 20 13:54:17 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:54:17 volumio volumio[4893]: info: ------------------------------ 5ms Feb 20 13:54:17 volumio volumio[4893]: info: Feb 20 13:54:17 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:54:17 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:54:17 volumio volumio[4893]: info: ------------------------------ 3ms Feb 20 13:54:17 volumio volumio[4893]: info: Feb 20 13:54:17 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:17 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:17 volumio volumio[4893]: info: Feb 20 13:54:17 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:17 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:17 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:17 volumio volumio[4893]: 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":null,"isStreaming":false,"title":"1739904130.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904130.ts?wsApp=HLS","trackType":""} Feb 20 13:54:17 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:17 volumio volumio[4893]: info: ------------------------------ 48ms Feb 20 13:54:17 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:17 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:17 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:17 volumio volumio[4893]: 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":"294 Kbps","isStreaming":false,"title":"1739904130.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904130.ts?wsApp=HLS","trackType":""} Feb 20 13:54:17 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:17 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:17 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:17 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:17 volumio volumio[4893]: info: ------------------------------ 39ms Feb 20 13:54:20 volumio volumio[4893]: info: Feb 20 13:54:20 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:20 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:20 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:20 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:20 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:20 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:20 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:20 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:20 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:20 volumio volumio[4893]: verbose: STATE SERVICE {"status":"play","position":1,"seek":383,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"273 Kbps","isStreaming":false,"title":"1739904131.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904131.ts?wsApp=HLS","trackType":""} Feb 20 13:54:20 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:20 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:20 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:20 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:20 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:20 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:20 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:20 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:20 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:20 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:20 volumio volumio[4893]: info: ------------------------------ 36ms Feb 20 13:54:21 volumio volumio[4893]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%88%91%E4%BB%8E%E8%8D%89%E5%8E%9F%E6%9D%A5/37de2946-e54b-4420-b9ea-5f0f2dd819e4.jpg' Feb 20 13:54:22 volumio volumio[4893]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%84%E9%9C%84%E9%9B%B2/%E6%98%9F%E8%BE%B0%E5%A4%A7%E6%B5%B7/22ef2dc6-5d88-4a0e-882c-ed36d1158f40.jpg' Feb 20 13:54:22 volumio volumio[4893]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%8D%E5%A4%AE%E5%8D%93%E7%8E%9B/%E9%87%91%E8%89%B2%E7%9A%84%E8%BE%89%E7%85%8C/01291c45-093f-4947-815f-1a83993b04b7.jpg' Feb 20 13:54:22 volumio volumio[4893]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%98%BF%E6%A2%A8%E7%B2%A4/%E6%99%9A%E9%A3%8E%E5%BF%83%E9%87%8C%E5%90%B9/33bd31ed-9387-4ae4-8ac0-2e8ad2a3d58d.jpg' Feb 20 13:54:22 volumio volumio[4893]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%88%91%E4%BB%8E%E8%8D%89%E5%8E%9F%E6%9D%A5/37de2946-e54b-4420-b9ea-5f0f2dd819e4.jpg' Feb 20 13:54:23 volumio volumio[4893]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Carpenters/Yesterday%20Once%20More/1e7724f9-2d2b-4a38-92e2-9e33961fb1c3.jpg' Feb 20 13:54:23 volumio volumio[4893]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%9F%A9%E5%AE%9D%E4%BB%AA/%E4%B8%80%E4%B8%AA%E5%B0%8F%E5%BE%AE%E7%AC%91/0275d93e-3225-4cba-8e19-17c7a3f3b1c1.jpg' Feb 20 13:54:23 volumio volumio[4893]: info: Feb 20 13:54:23 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:23 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:23 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:23 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:23 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:23 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:23 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:23 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:23 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:23 volumio volumio[4893]: verbose: STATE SERVICE {"status":"play","position":2,"seek":480,"duration":3,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"1739904132.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904132.ts?wsApp=HLS","trackType":""} Feb 20 13:54:23 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:23 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:23 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:23 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:23 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:23 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:23 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:23 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:23 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:23 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:23 volumio volumio[4893]: info: ------------------------------ 34ms Feb 20 13:54:26 volumio volumio[4893]: info: Feb 20 13:54:26 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:26 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:26 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:26 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:26 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:26 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:26 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:26 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:26 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:26 volumio volumio[4893]: 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 13:54:26 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:26 volumio volumio[4893]: info: CoreStateMachine::syncState stateService stop Feb 20 13:54:26 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:26 volumio volumio[4893]: info: CoreStateMachine::play index undefined Feb 20 13:54:26 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 13:54:26 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:26 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:26 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:26 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:26 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:26 volumio volumio[4893]: info: CoreStateMachine::startPlaybackTimer Feb 20 13:54:26 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:26 volumio volumio[4893]: info: [1740059666943] ControllerWebradio::clearAddPlayTrack Feb 20 13:54:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 13:54:26 volumio volumio[4893]: info: ------------------------------ 29ms Feb 20 13:54:26 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:26 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:26 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:26 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 13:54:26 volumio volumio[4893]: info: Feb 20 13:54:26 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:54:26 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:54:26 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand load "https://sk.cri.cn/887.m3u8" Feb 20 13:54:26 volumio volumio[4893]: error: updateQueue error: null Feb 20 13:54:26 volumio volumio[4893]: info: ------------------------------ 4ms Feb 20 13:54:27 volumio volumio[4893]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand play Feb 20 13:54:27 volumio volumio[4893]: info: Feb 20 13:54:27 volumio volumio[4893]: ---------------------------- MPD announces system playlist update Feb 20 13:54:27 volumio volumio[4893]: info: Ignoring MPD Status Update Feb 20 13:54:27 volumio volumio[4893]: info: ------------------------------ 2ms Feb 20 13:54:27 volumio volumio[4893]: info: Feb 20 13:54:27 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:27 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:27 volumio volumio[4893]: info: Feb 20 13:54:27 volumio volumio[4893]: ---------------------------- MPD announces state update: player Feb 20 13:54:27 volumio volumio[4893]: info: ControllerMpd::getState Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand status Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::parseState Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:27 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:27 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:27 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:27 volumio volumio[4893]: 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":"271 Kbps","isStreaming":false,"title":"1739904133.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904133.ts?wsApp=HLS","trackType":""} Feb 20 13:54:27 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:27 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:27 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus stop Feb 20 13:54:27 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:27 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:27 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:27 volumio volumio[4893]: info: ------------------------------ 39ms Feb 20 13:54:27 volumio volumio[4893]: verbose: ControllerMpd::parseTrackInfo Feb 20 13:54:27 volumio volumio[4893]: info: ControllerMpd::pushState Feb 20 13:54:27 volumio volumio[4893]: info: CoreCommandRouter::servicePushState Feb 20 13:54:27 volumio volumio[4893]: info: CorePlayQueue::getTrack 0 Feb 20 13:54:27 volumio volumio[4893]: 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":"242 Kbps","isStreaming":false,"title":"1739904133.ts?wsApp=HLS","artist":null,"album":null,"uri":"https://sk.cri.cn/887/1739904133.ts?wsApp=HLS","trackType":""} Feb 20 13:54:27 volumio volumio[4893]: verbose: CURRENT POSITION 0 Feb 20 13:54:27 volumio volumio[4893]: info: CoreStateMachine::syncState stateService play Feb 20 13:54:27 volumio volumio[4893]: info: CoreStateMachine::syncState currentStatus play Feb 20 13:54:27 volumio volumio[4893]: info: Received an update from plugin. extracting info from payload Feb 20 13:54:27 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:27 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:27 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:27 volumio volumio[4893]: info: CoreStateMachine::pushState Feb 20 13:54:27 volumio volumio[4893]: info: CoreCommandRouter::volumioPushState Feb 20 13:54:27 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 13:54:27 volumio volumio[4893]: info: ------------------------------ 34ms Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 20 13:54:29 volumio volumio[4893]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 20 13:54:29 volumio volumio[4893]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 20 13:54:29 volumio volumio[4893]: { Error: connect ETIMEDOUT 168.143.162.58:443 Feb 20 13:54:29 volumio volumio[4893]: at Object._errnoException (util.js:1022:11) Feb 20 13:54:29 volumio volumio[4893]: at _exceptionWithHostPort (util.js:1044:20) Feb 20 13:54:29 volumio volumio[4893]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Feb 20 13:54:29 volumio volumio[4893]: code: 'ETIMEDOUT', Feb 20 13:54:29 volumio volumio[4893]: errno: 'ETIMEDOUT', Feb 20 13:54:29 volumio volumio[4893]: syscall: 'connect', Feb 20 13:54:29 volumio volumio[4893]: address: '168.143.162.58', Feb 20 13:54:29 volumio volumio[4893]: port: 443 } Feb 20 13:54:29 volumio volumio[4893]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 20 13:54:30 volumio sudo[5770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-20 13:53 Feb 20 13:54:30 volumio sudo[5770]: 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"