-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Wed 2024-07-10 10:59:07 CST. -- Jul 10 10:58:00 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 10 10:58:05 volumio kernel: hwmon hwmon1: Voltage normalised Jul 10 10:58:05 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:06 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:07 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:07 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:07 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:07 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:07 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:07 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:07 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:07 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:07 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:07 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:07 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:07 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:07 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:07 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:07 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:07 volumio volumio[859]: info: Jul 10 10:58:07 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:07 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds Jul 10 10:58:07 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:07 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:07 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:07 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:07 volumio volumio[859]: info: sendMpdCommand status took 4 milliseconds Jul 10 10:58:07 volumio volumio[859]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 10 10:58:07 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:07 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:07 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:07 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:07 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:07 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":494,"samplerate":"12 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"传奇","artist":"栗宏涛","album":"吉他吧的故事","uri":"http://m701.music.126.net/20240710112249/a72635c3c235b26c19d058e96f19b401/jdyyaac/025b/035c/020b/519210b9fd46e3d60f265a09bae42273.m4a","trackType":"m4a"} Jul 10 10:58:07 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 15ms Jul 10 10:58:07 volumio volumio[859]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 10 10:58:07 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:07 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:07 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:07 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":494,"samplerate":"12 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"传奇","artist":"栗宏涛","album":"吉他吧的故事","uri":"http://m701.music.126.net/20240710112249/a72635c3c235b26c19d058e96f19b401/jdyyaac/025b/035c/020b/519210b9fd46e3d60f265a09bae42273.m4a","trackType":"m4a"} Jul 10 10:58:07 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:07 volumio volumio[859]: info: Received an update from plugin. extracting info from payload Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:07 volumio volumio[859]: info: ------------------------------ 51ms Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:07 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:07 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:07 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:07 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:09 volumio volumio[859]: info: Jul 10 10:58:09 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:09 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:09 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:09 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:09 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds Jul 10 10:58:09 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:09 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:09 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:09 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:09 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:09 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:09 volumio volumio[859]: 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} Jul 10 10:58:09 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:09 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:09 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:09 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:09 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer Jul 10 10:58:09 volumio volumio[859]: info: ------------------------------ 27ms Jul 10 10:58:09 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:09 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:09 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:09 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 10 10:58:10 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:11 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:11 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:11 volumio volumio[859]: info: Jul 10 10:58:11 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:11 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:11 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:11 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:11 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:11 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:11 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:11 volumio volumio[859]: info: Jul 10 10:58:11 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:11 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:11 volumio volumio[859]: info: Jul 10 10:58:11 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:11 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:11 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:11 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:11 volumio volumio[859]: info: Jul 10 10:58:11 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:11 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:11 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:11 volumio volumio[859]: info: Jul 10 10:58:11 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:11 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:11 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:11 volumio volumio[859]: info: Jul 10 10:58:11 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:11 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:11 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:11 volumio volumio[859]: info: Jul 10 10:58:11 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:11 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:11 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:11 volumio volumio[859]: info: Jul 10 10:58:11 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:11 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:11 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:11 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 10 10:58:11 volumio volumio[859]: info: sendMpdCommand status took 8 milliseconds Jul 10 10:58:11 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:11 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:11 volumio volumio[859]: info: sendMpdCommand clearerror took 3 milliseconds Jul 10 10:58:11 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 10:58:11 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:11 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:11 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:11 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 10:58:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:11 volumio volumio[859]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"这条小鱼在乎","artist":"王OK/洪佩瑜","album":"不完全自救手册","uri":"http://m701.music.126.net/20240710112310/78a0d401602188fa9d21366fe449a7da/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/35520130059/7b1a/2b69/c2d1/21869d0191db51316aa461a9502b5a52.m4a","trackType":"m4a"} Jul 10 10:58:11 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:11 volumio volumio[859]: info: No code Jul 10 10:58:11 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:11 volumio volumio[859]: info: ------------------------------ 56ms Jul 10 10:58:17 volumio kernel: hwmon hwmon1: Voltage normalised Jul 10 10:58:21 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:21 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:21 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:21 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:21 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:21 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:21 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:21 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:21 volumio volumio[859]: info: Jul 10 10:58:21 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:21 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:21 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:21 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:21 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:21 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:21 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:21 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:21 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:21 volumio volumio[859]: info: Jul 10 10:58:21 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:21 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:21 volumio volumio[859]: info: Jul 10 10:58:21 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:21 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:21 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:21 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:21 volumio volumio[859]: info: Jul 10 10:58:21 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:21 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:21 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:21 volumio volumio[859]: info: Jul 10 10:58:21 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:21 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:21 volumio volumio[859]: info: ------------------------------ 4ms Jul 10 10:58:21 volumio volumio[859]: info: Jul 10 10:58:21 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:21 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:21 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:21 volumio volumio[859]: info: Jul 10 10:58:21 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:21 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:22 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:22 volumio volumio[859]: info: Jul 10 10:58:22 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:22 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:22 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:22 volumio volumio[859]: info: Jul 10 10:58:22 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:22 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:22 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:22 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds Jul 10 10:58:22 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:22 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:22 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:22 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds Jul 10 10:58:22 volumio volumio[859]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 10 10:58:22 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:22 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:22 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:22 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:22 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:22 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:22 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":475,"samplerate":"8 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"岁月神偷","artist":"金玟岐","album":"完美世界","uri":"http://m701.music.126.net/20240710112321/aa7fbde16c1fcdbe954bd5274140e922/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26669815522/6cf8/12f7/3002/a9d16cf230d3eb76a4a4695316dfe24e.m4a","trackType":"m4a"} Jul 10 10:58:22 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:22 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:22 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:22 volumio volumio[859]: info: ------------------------------ 6ms Jul 10 10:58:22 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 10:58:22 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:22 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:22 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:22 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:22 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":475,"samplerate":"8 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"岁月神偷","artist":"金玟岐","album":"完美世界","uri":"http://m701.music.126.net/20240710112321/aa7fbde16c1fcdbe954bd5274140e922/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26669815522/6cf8/12f7/3002/a9d16cf230d3eb76a4a4695316dfe24e.m4a","trackType":"m4a"} Jul 10 10:58:22 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:22 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:22 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:22 volumio volumio[859]: info: Received an update from plugin. extracting info from payload Jul 10 10:58:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 10:58:22 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:22 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 10:58:22 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:22 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:22 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:22 volumio volumio[859]: info: ------------------------------ 38ms Jul 10 10:58:22 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:22 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:22 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:22 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:22 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:22 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:23 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 10 10:58:24 volumio volumio[859]: info: Jul 10 10:58:24 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:24 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:24 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:24 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:24 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds Jul 10 10:58:24 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:24 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:24 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:24 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:24 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:24 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:24 volumio volumio[859]: 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} Jul 10 10:58:24 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:24 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:24 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:24 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:24 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer Jul 10 10:58:24 volumio volumio[859]: info: ------------------------------ 27ms Jul 10 10:58:24 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:24 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:24 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:27 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:28 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:28 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:28 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:28 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:28 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:28 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:28 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:28 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:28 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:28 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:28 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:28 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:28 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:28 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:28 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:28 volumio volumio[859]: info: Jul 10 10:58:28 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:28 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:28 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:28 volumio volumio[859]: info: sendMpdCommand status took 3 milliseconds Jul 10 10:58:28 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:28 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:28 volumio volumio[859]: info: sendMpdCommand status took 4 milliseconds Jul 10 10:58:28 volumio volumio[859]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 10 10:58:28 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:28 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:28 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:28 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:28 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:28 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":406,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"岁月神偷","artist":"金玟岐","album":"完美世界","uri":"http://m701.music.126.net/20240710112327/a0b71b429799dc447a362029421406e7/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26669815522/6cf8/12f7/3002/a9d16cf230d3eb76a4a4695316dfe24e.m4a","trackType":"m4a"} Jul 10 10:58:28 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 16ms Jul 10 10:58:28 volumio volumio[859]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 10 10:58:28 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:28 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:28 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:28 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":406,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"岁月神偷","artist":"金玟岐","album":"完美世界","uri":"http://m701.music.126.net/20240710112327/a0b71b429799dc447a362029421406e7/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26669815522/6cf8/12f7/3002/a9d16cf230d3eb76a4a4695316dfe24e.m4a","trackType":"m4a"} Jul 10 10:58:28 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:28 volumio volumio[859]: info: Received an update from plugin. extracting info from payload Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:28 volumio volumio[859]: info: ------------------------------ 49ms Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:28 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:28 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:28 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:28 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:29 volumio volumio[859]: info: Jul 10 10:58:29 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:29 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:29 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:29 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds Jul 10 10:58:29 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:29 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:29 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:29 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:29 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:29 volumio volumio[859]: 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} Jul 10 10:58:29 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:29 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:29 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:29 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:29 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer Jul 10 10:58:29 volumio volumio[859]: info: ------------------------------ 36ms Jul 10 10:58:29 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:29 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:29 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:32 volumio kernel: hwmon hwmon1: Voltage normalised Jul 10 10:58:32 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:33 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:33 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:33 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:33 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:33 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:33 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:33 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:33 volumio volumio[859]: info: Jul 10 10:58:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:33 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:33 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:33 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:33 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:33 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:33 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:33 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:33 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:33 volumio volumio[859]: info: Jul 10 10:58:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:33 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:33 volumio volumio[859]: info: Jul 10 10:58:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:33 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:33 volumio volumio[859]: info: ------------------------------ 4ms Jul 10 10:58:33 volumio volumio[859]: info: ------------------------------ 16ms Jul 10 10:58:33 volumio volumio[859]: info: Jul 10 10:58:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:33 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:33 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:33 volumio volumio[859]: info: Jul 10 10:58:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:33 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:33 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:33 volumio volumio[859]: info: Jul 10 10:58:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:33 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:33 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:33 volumio volumio[859]: info: Jul 10 10:58:33 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:33 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:33 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:34 volumio volumio[859]: info: Jul 10 10:58:34 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:34 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:34 volumio volumio[859]: info: Jul 10 10:58:34 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:34 volumio volumio[859]: info: sendMpdCommand status took 5 milliseconds Jul 10 10:58:34 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:34 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:34 volumio volumio[859]: info: sendMpdCommand status took 4 milliseconds Jul 10 10:58:34 volumio volumio[859]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:34 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:34 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:34 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1232,"samplerate":"12 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"岁月神偷","artist":"金玟岐","album":"完美世界","uri":"http://m701.music.126.net/20240710112332/dea125a03d9a6561824f77017da5771e/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26669815522/6cf8/12f7/3002/a9d16cf230d3eb76a4a4695316dfe24e.m4a","trackType":"m4a"} Jul 10 10:58:34 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:34 volumio volumio[859]: info: ------------------------------ 20ms Jul 10 10:58:34 volumio volumio[859]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:34 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:34 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:34 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1232,"samplerate":"12 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"岁月神偷","artist":"金玟岐","album":"完美世界","uri":"http://m701.music.126.net/20240710112332/dea125a03d9a6561824f77017da5771e/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26669815522/6cf8/12f7/3002/a9d16cf230d3eb76a4a4695316dfe24e.m4a","trackType":"m4a"} Jul 10 10:58:34 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:34 volumio volumio[859]: info: Received an update from plugin. extracting info from payload Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:34 volumio volumio[859]: info: ------------------------------ 46ms Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:34 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:34 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:34 volumio volumio[859]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%87%91%E7%8E%9F%E5%B2%90/%E5%AE%8C%E7%BE%8E%E4%B8%96%E7%95%8C/8ec70a8c-75ec-4e1d-ac8f-1944b342a6da.jpg' Jul 10 10:58:34 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 10 10:58:34 volumio volumio[859]: info: Jul 10 10:58:34 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:34 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:34 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:34 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds Jul 10 10:58:34 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:34 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:34 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:34 volumio volumio[859]: 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} Jul 10 10:58:34 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer Jul 10 10:58:34 volumio volumio[859]: info: ------------------------------ 26ms Jul 10 10:58:34 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:34 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:34 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:36 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:36 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:36 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:36 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:36 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:36 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:36 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:36 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:36 volumio volumio[859]: info: Jul 10 10:58:36 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:36 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:36 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:36 volumio volumio[859]: info: ------------------------------ 1ms Jul 10 10:58:36 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:36 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:36 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:36 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:36 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:37 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:37 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:37 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:37 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:37 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:37 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:37 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:37 volumio volumio[859]: info: sendMpdCommand status took 7 milliseconds Jul 10 10:58:37 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:37 volumio volumio[859]: info: sendMpdCommand status took 4 milliseconds Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:37 volumio volumio[859]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 10 10:58:37 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:37 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:37 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:37 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":466,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"岁月神偷","artist":"金玟岐","album":"完美世界","uri":"http://m801.music.126.net/20240710112336/e71e04771ee6029fd0763ea5f5d277a4/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26669815522/6cf8/12f7/3002/a9d16cf230d3eb76a4a4695316dfe24e.m4a","trackType":"m4a"} Jul 10 10:58:37 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:37 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:37 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:37 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":466,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"岁月神偷","artist":"金玟岐","album":"完美世界","uri":"http://m801.music.126.net/20240710112336/e71e04771ee6029fd0763ea5f5d277a4/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/26669815522/6cf8/12f7/3002/a9d16cf230d3eb76a4a4695316dfe24e.m4a","trackType":"m4a"} Jul 10 10:58:37 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:37 volumio volumio[859]: info: Received an update from plugin. extracting info from payload Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 34ms Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 43ms Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:37 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:37 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:37 volumio volumio[859]: info: Jul 10 10:58:37 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:37 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:37 volumio volumio[859]: info: sendMpdCommand status took 2 milliseconds Jul 10 10:58:37 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:37 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:37 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:37 volumio volumio[859]: 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} Jul 10 10:58:37 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:37 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:37 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer Jul 10 10:58:37 volumio volumio[859]: info: ------------------------------ 34ms Jul 10 10:58:38 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:38 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:38 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:38 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:39 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:39 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:39 volumio volumio[859]: info: Jul 10 10:58:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:39 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:39 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:39 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:39 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:39 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:39 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:39 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:39 volumio volumio[859]: info: Jul 10 10:58:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:39 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:39 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:39 volumio volumio[859]: info: Jul 10 10:58:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:39 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:39 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:39 volumio volumio[859]: info: Jul 10 10:58:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:39 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:39 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:39 volumio volumio[859]: info: Jul 10 10:58:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:39 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:39 volumio volumio[859]: info: ------------------------------ 8ms Jul 10 10:58:39 volumio volumio[859]: info: Jul 10 10:58:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:39 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:39 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:39 volumio volumio[859]: info: Jul 10 10:58:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:39 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:39 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:39 volumio volumio[859]: error: error Jul 10 10:58:39 volumio volumio[859]: error: error Jul 10 10:58:39 volumio volumio[859]: info: Jul 10 10:58:39 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:39 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 10 10:58:39 volumio volumio[859]: info: sendMpdCommand status took 12 milliseconds Jul 10 10:58:39 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:39 volumio volumio[859]: info: sendMpdCommand clearerror took 3 milliseconds Jul 10 10:58:39 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 10:58:39 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:39 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:39 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:39 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 10:58:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:39 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:39 volumio volumio[859]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"不要说话","artist":"陈奕迅","album":"不想放手","uri":"http://m801.music.126.net/20240710112338/1ae5a0bfac11543bd7dcd440bdc718b1/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/28481699179/6364/0c63/26e7/b76cc5ac89451815083eaea919084bc9.m4a","trackType":"m4a"} Jul 10 10:58:39 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:39 volumio volumio[859]: info: No code Jul 10 10:58:39 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:39 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:39 volumio volumio[859]: info: ------------------------------ 50ms Jul 10 10:58:39 volumio volumio[859]: error: error Jul 10 10:58:39 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:40 volumio volumio[859]: error: error Jul 10 10:58:41 volumio volumio[859]: error: error Jul 10 10:58:41 volumio volumio[859]: error: error Jul 10 10:58:41 volumio volumio[859]: error: error Jul 10 10:58:41 volumio volumio[859]: error: error Jul 10 10:58:46 volumio kernel: hwmon hwmon1: Voltage normalised Jul 10 10:58:50 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:50 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:50 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:50 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:50 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:50 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:50 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:50 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:50 volumio volumio[859]: info: Jul 10 10:58:50 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:50 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:50 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:50 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:50 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:50 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:50 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:50 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:50 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:50 volumio volumio[859]: info: Jul 10 10:58:50 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:50 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:50 volumio volumio[859]: info: Jul 10 10:58:50 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:50 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:50 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:50 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:50 volumio volumio[859]: info: Jul 10 10:58:50 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:50 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:50 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:50 volumio volumio[859]: info: Jul 10 10:58:50 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:50 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:50 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:50 volumio volumio[859]: info: Jul 10 10:58:50 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:50 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:50 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:50 volumio volumio[859]: info: Jul 10 10:58:50 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:50 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:50 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:50 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 10 10:58:51 volumio volumio[859]: info: Jul 10 10:58:51 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:51 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:51 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:51 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 10 10:58:51 volumio volumio[859]: info: sendMpdCommand status took 8 milliseconds Jul 10 10:58:51 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:51 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:51 volumio volumio[859]: info: sendMpdCommand clearerror took 3 milliseconds Jul 10 10:58:51 volumio volumio[859]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 10:58:51 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:51 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:51 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:51 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:51 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:51 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:51 volumio volumio[859]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"驿动的心","artist":"蔡琴","album":"遇见","uri":"http://m8.music.126.net/20240710112349/bc37554ef4841890b5750bc0dec95747/yyaac/0f08/065b/0109/8be8cd00cc119d3448cf6c0dfa891ca9.m4a","trackType":"m4a"} Jul 10 10:58:51 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:51 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:51 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:51 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:51 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:51 volumio volumio[859]: info: No code Jul 10 10:58:51 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:51 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:51 volumio volumio[859]: info: ------------------------------ 46ms Jul 10 10:58:51 volumio volumio[859]: info: Clearing queue after UPNP request Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::ClearQueue Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::stop Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 10:58:52 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue Jul 10 10:58:52 volumio volumio[859]: info: CorePlayQueue::saveQueue Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:52 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:52 volumio volumio[859]: error: updateQueue error: null Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:52 volumio volumio[859]: info: Starting UPNP Playback Jul 10 10:58:52 volumio volumio[859]: info: Preparing playback through UPNP Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Jul 10 10:58:52 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:52 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:52 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:52 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:52 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:52 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 2ms Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces system playlist update Jul 10 10:58:52 volumio volumio[859]: info: Ignoring MPD Status Update Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 3ms Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:52 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:52 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:52 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:52 volumio volumio[859]: info: Jul 10 10:58:52 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:52 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:52 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:52 volumio volumio[859]: info: sendMpdCommand status took 6 milliseconds Jul 10 10:58:52 volumio volumio[859]: info: sendMpdCommand status took 4 milliseconds Jul 10 10:58:52 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:52 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:52 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:52 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 10:58:52 volumio volumio[859]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 10 10:58:52 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo Jul 10 10:58:52 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:52 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:52 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"12 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"借","artist":"毛不易","album":"平凡的一天","uri":"http://m701.music.126.net/20240710112351/0392f1583aa548bcb5131c1d1b619f67/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/28481668469/a578/a3b2/c7c6/f175e40d1f1167854b1efd5633c51d69.m4a","trackType":"m4a"} Jul 10 10:58:52 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Jul 10 10:58:52 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:52 volumio volumio[859]: verbose: In UPNP mode Jul 10 10:58:52 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"12 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"借","artist":"毛不易","album":"平凡的一天","uri":"http://m701.music.126.net/20240710112351/0392f1583aa548bcb5131c1d1b619f67/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/28481668469/a578/a3b2/c7c6/f175e40d1f1167854b1efd5633c51d69.m4a","trackType":"m4a"} Jul 10 10:58:52 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::syncState stateService play Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:52 volumio volumio[859]: info: Received an update from plugin. extracting info from payload Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 46ms Jul 10 10:58:52 volumio volumio[859]: info: ------------------------------ 55ms Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:52 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:52 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:52 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:52 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:53 volumio volumio[859]: info: Jul 10 10:58:53 volumio volumio[859]: ---------------------------- MPD announces state update: player Jul 10 10:58:53 volumio volumio[859]: info: ControllerMpd::getState Jul 10 10:58:53 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Jul 10 10:58:53 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds Jul 10 10:58:53 volumio volumio[859]: verbose: ControllerMpd::parseState Jul 10 10:58:53 volumio volumio[859]: info: ControllerMpd::pushState Jul 10 10:58:53 volumio volumio[859]: info: CoreCommandRouter::servicePushState Jul 10 10:58:53 volumio volumio[859]: info: CoreStateMachine::pushState Jul 10 10:58:53 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 10 10:58:53 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:53 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Jul 10 10:58:53 volumio volumio[859]: 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} Jul 10 10:58:53 volumio volumio[859]: verbose: CURRENT POSITION 0 Jul 10 10:58:53 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Jul 10 10:58:53 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play Jul 10 10:58:53 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Jul 10 10:58:53 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer Jul 10 10:58:53 volumio volumio[859]: info: ------------------------------ 11ms Jul 10 10:58:53 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Jul 10 10:58:53 volumio volumio[859]: info: CoreStateMachine::getQueue Jul 10 10:58:53 volumio volumio[859]: info: CorePlayQueue::getQueue Jul 10 10:58:57 volumio kernel: hwmon hwmon1: Voltage normalised Jul 10 10:59:01 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 10 10:59:04 volumio volumio[859]: info: CoreCommandRouter::volumioNext Jul 10 10:59:04 volumio volumio[859]: info: CoreStateMachine::next Jul 10 10:59:04 volumio volumio[859]: info: ControllerMpd::next Jul 10 10:59:04 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand next Jul 10 10:59:05 volumio kernel: hwmon hwmon1: Voltage normalised Jul 10 10:59:06 volumio volumio[859]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 10:59:06 volumio volumio[859]: Error: connect ETIMEDOUT 150.107.3.176:443 Jul 10 10:59:06 volumio volumio[859]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jul 10 10:59:06 volumio volumio[859]: errno: -110, Jul 10 10:59:06 volumio volumio[859]: code: 'ETIMEDOUT', Jul 10 10:59:06 volumio volumio[859]: syscall: 'connect', Jul 10 10:59:06 volumio volumio[859]: address: '150.107.3.176', Jul 10 10:59:06 volumio volumio[859]: port: 443 Jul 10 10:59:06 volumio volumio[859]: } Jul 10 10:59:06 volumio volumio[859]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 10:59:07 volumio sudo[1841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-10 10:58 Jul 10 10:59:07 volumio sudo[1841]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"