-- Logs begin at Wed 2022-12-14 12:36:47 UTC, end at Thu 2025-05-15 12:28:26 UTC. -- May 15 12:27:26 opera volumio[5023]: info: May 15 12:27:26 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:27:26 opera volumio[5023]: info: ControllerMpd::getState May 15 12:27:26 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:27:26 opera volumio[5023]: info: sendMpdCommand status took 1 milliseconds May 15 12:27:26 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:27:26 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:27:26 opera volumio[5023]: info: sendMpdCommand playlistinfo took 0 milliseconds May 15 12:27:26 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:27:26 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:27:26 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:27:26 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:26 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:26 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:26 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:27:26 opera volumio[5023]: 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":"https://aqqmusic.tc.qq.com/F000002wmp2r0oms0v.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=345275260C1AECA45B04D24E17030B57C3E887D3AF570BBDF2946E0C60233D48F83E56D962C58454BB6DE88C64198103042D0CFE3D35C314__v21530b759&uin=1152921504724187376&src=F00000071y6r2zXgzE.flac&redirect=1&fromtag=111114","trackType":""} May 15 12:27:26 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:27:26 opera volumio[5023]: info: CoreStateMachine::syncState stateService stop May 15 12:27:26 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus play May 15 12:27:26 opera volumio[5023]: info: CoreStateMachine::play index undefined May 15 12:27:26 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:27:26 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:26 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:27:26 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:26 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:26 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:27:26 opera volumio[5023]: info: ------------------------------ 16ms May 15 12:27:26 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:26 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:26 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:27:26 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:27:26 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:27:28 opera volumio[5023]: info: Clearing queue after UPNP request May 15 12:27:28 opera volumio[5023]: info: CoreStateMachine::ClearQueue May 15 12:27:28 opera volumio[5023]: info: CoreStateMachine::stop May 15 12:27:28 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:27:28 opera volumio[5023]: verbose: UNSET VOLATILE May 15 12:27:28 opera volumio[5023]: info: CorePlayQueue::clearPlayQueue May 15 12:27:28 opera volumio[5023]: info: CorePlayQueue::saveQueue May 15 12:27:28 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:28 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:28 opera volumio[5023]: info: CoreCommandRouter::volumioPushQueue May 15 12:27:28 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:28 opera volumio[5023]: info: May 15 12:27:28 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:28 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:28 opera volumio[5023]: error: updateQueue error: null May 15 12:27:28 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:28 opera volumio[5023]: info: Starting UPNP Playback May 15 12:27:28 opera volumio[5023]: info: Preparing playback through UPNP May 15 12:27:28 opera volumio[5023]: info: CoreCommandRouter::volumioGetState May 15 12:27:28 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:27:28 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService mpd May 15 12:27:28 opera volumio[5023]: info: May 15 12:27:28 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:28 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:28 opera volumio[5023]: info: May 15 12:27:28 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:28 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:28 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:28 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:28 opera volumio[5023]: info: May 15 12:27:28 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:28 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:28 opera volumio[5023]: info: ------------------------------ 6ms May 15 12:27:28 opera volumio[5023]: info: May 15 12:27:28 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:28 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:28 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:28 opera volumio[5023]: info: May 15 12:27:28 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:28 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:28 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:28 opera volumio[5023]: info: May 15 12:27:28 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:28 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:28 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:29 opera volumio[5023]: info: May 15 12:27:29 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:27:29 opera volumio[5023]: info: ControllerMpd::getState May 15 12:27:29 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:27:29 opera volumio[5023]: info: May 15 12:27:29 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:27:29 opera volumio[5023]: info: sendMpdCommand status took 123 milliseconds May 15 12:27:29 opera volumio[5023]: info: ControllerMpd::getState May 15 12:27:29 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:27:29 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:27:29 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:27:29 opera volumio[5023]: info: May 15 12:27:29 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:29 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:29 opera volumio[5023]: info: sendMpdCommand status took 7 milliseconds May 15 12:27:29 opera volumio[5023]: info: sendMpdCommand playlistinfo took 7 milliseconds May 15 12:27:29 opera volumio[5023]: info: ------------------------------ 6ms May 15 12:27:29 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:27:29 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:27:29 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:27:29 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:27:29 opera volumio[5023]: verbose: In UPNP mode May 15 12:27:29 opera volumio[5023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":297,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"一切都来得及","artist":"贾玲","album":"一切都来得及（电影《热辣滚烫》热辣蜕变曲）","uri":"https://aqqmusic.tc.qq.com/M500002VKvPZ0di33Y.mp3?guid=ffffffff940390ae0000018aef37fd87&vkey=283446F7F6F59D3E97160911E30DD101F8C925F4D08A02015B04751E40359D3A1F4EEB63674BF9E34FA2E20EBA696BE3FA494B3B7615368E__v21e2978b9&uin=1152921504724187376&src=M500000Thags0dKSwz.mp3&redirect=1&fromtag=111042","trackType":""} May 15 12:27:29 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::syncState stateService play May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus stop May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:29 opera volumio[5023]: info: ------------------------------ 139ms May 15 12:27:29 opera volumio[5023]: info: sendMpdCommand playlistinfo took 9 milliseconds May 15 12:27:29 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:27:29 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:27:29 opera volumio[5023]: verbose: In UPNP mode May 15 12:27:29 opera volumio[5023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":297,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"一切都来得及","artist":"贾玲","album":"一切都来得及（电影《热辣滚烫》热辣蜕变曲）","uri":"https://aqqmusic.tc.qq.com/M500002VKvPZ0di33Y.mp3?guid=ffffffff940390ae0000018aef37fd87&vkey=283446F7F6F59D3E97160911E30DD101F8C925F4D08A02015B04751E40359D3A1F4EEB63674BF9E34FA2E20EBA696BE3FA494B3B7615368E__v21e2978b9&uin=1152921504724187376&src=M500000Thags0dKSwz.mp3&redirect=1&fromtag=111042","trackType":""} May 15 12:27:29 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::syncState stateService play May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus play May 15 12:27:29 opera volumio[5023]: info: Received an update from plugin. extracting info from payload May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:29 opera volumio[5023]: info: ------------------------------ 35ms May 15 12:27:29 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:29 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:27:29 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:27:29 opera volumio[5023]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%B7%B1/%E8%A7%A6%E4%B8%8D%E5%8F%AF%E5%8F%8A/d90e7e0c-3a7a-45f4-aaf0-e85cce964831.png' May 15 12:27:29 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:29 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:27:29 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:27:29 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:27:30 opera volumio[5023]: info: May 15 12:27:30 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:27:30 opera volumio[5023]: info: ControllerMpd::getState May 15 12:27:30 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:27:30 opera volumio[5023]: info: sendMpdCommand status took 3 milliseconds May 15 12:27:30 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:27:30 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:27:30 opera volumio[5023]: info: sendMpdCommand playlistinfo took 1 milliseconds May 15 12:27:30 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:27:30 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:30 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:27:30 opera volumio[5023]: 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":"https://aqqmusic.tc.qq.com/M500002VKvPZ0di33Y.mp3?guid=ffffffff940390ae0000018aef37fd87&vkey=283446F7F6F59D3E97160911E30DD101F8C925F4D08A02015B04751E40359D3A1F4EEB63674BF9E34FA2E20EBA696BE3FA494B3B7615368E__v21e2978b9&uin=1152921504724187376&src=M500000Thags0dKSwz.mp3&redirect=1&fromtag=111042","trackType":""} May 15 12:27:30 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::syncState stateService stop May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus play May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::play index undefined May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:30 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:30 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:27:30 opera volumio[5023]: info: ------------------------------ 15ms May 15 12:27:30 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:30 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:27:30 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:27:30 opera volumio[5023]: info: Clearing queue after UPNP request May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::ClearQueue May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::stop May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:27:30 opera volumio[5023]: verbose: UNSET VOLATILE May 15 12:27:30 opera volumio[5023]: info: CorePlayQueue::clearPlayQueue May 15 12:27:30 opera volumio[5023]: info: CorePlayQueue::saveQueue May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::volumioPushQueue May 15 12:27:30 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:30 opera volumio[5023]: info: May 15 12:27:30 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:30 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:30 opera volumio[5023]: error: updateQueue error: null May 15 12:27:30 opera volumio[5023]: info: ------------------------------ 2ms May 15 12:27:30 opera volumio[5023]: info: Starting UPNP Playback May 15 12:27:30 opera volumio[5023]: info: Preparing playback through UPNP May 15 12:27:30 opera volumio[5023]: info: CoreCommandRouter::volumioGetState May 15 12:27:30 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:27:30 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService mpd May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:31 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:31 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:31 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:31 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:31 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:31 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:27:31 opera volumio[5023]: info: ControllerMpd::getState May 15 12:27:31 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:27:31 opera volumio[5023]: info: ControllerMpd::getState May 15 12:27:31 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:27:31 opera volumio[5023]: info: sendMpdCommand status took 4 milliseconds May 15 12:27:31 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:27:31 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:27:31 opera volumio[5023]: info: May 15 12:27:31 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:27:31 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:27:31 opera volumio[5023]: info: sendMpdCommand status took 6 milliseconds May 15 12:27:31 opera volumio[5023]: info: sendMpdCommand playlistinfo took 2 milliseconds May 15 12:27:31 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:27:31 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:27:31 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:27:31 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:27:31 opera volumio[5023]: verbose: In UPNP mode May 15 12:27:31 opera volumio[5023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天际","artist":"霖超凡","album":"天际","uri":"https://aqqmusic.tc.qq.com/F00000208O1D1gKIZ0.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=AEC97AE471BAF6D9FBF5B988361CFA125CB57241D5F2DD0DE5FD192FB80120612F68034DDAD20EE78FC3C2D501354139E4283EE9218B7DB3__v21ea05af1&uin=1152921504724187376&redirect=1&fromtag=111114","trackType":""} May 15 12:27:31 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::syncState stateService play May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus stop May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 29ms May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 21ms May 15 12:27:31 opera volumio[5023]: info: sendMpdCommand playlistinfo took 19 milliseconds May 15 12:27:31 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:27:31 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:27:31 opera volumio[5023]: verbose: In UPNP mode May 15 12:27:31 opera volumio[5023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"148 Kbps","isStreaming":false,"title":"天际","artist":"霖超凡","album":"天际","uri":"https://aqqmusic.tc.qq.com/F00000208O1D1gKIZ0.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=AEC97AE471BAF6D9FBF5B988361CFA125CB57241D5F2DD0DE5FD192FB80120612F68034DDAD20EE78FC3C2D501354139E4283EE9218B7DB3__v21ea05af1&uin=1152921504724187376&redirect=1&fromtag=111114","trackType":""} May 15 12:27:31 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::syncState stateService play May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus play May 15 12:27:31 opera volumio[5023]: info: Received an update from plugin. extracting info from payload May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:27:31 opera volumio[5023]: info: ------------------------------ 36ms May 15 12:27:31 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:31 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:31 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:27:31 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:27:31 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:27:31 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:27:31 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:28:02 opera volumio[5023]: info: May 15 12:28:02 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:28:02 opera volumio[5023]: info: ControllerMpd::getState May 15 12:28:02 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:28:02 opera volumio[5023]: info: sendMpdCommand status took 3 milliseconds May 15 12:28:02 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:28:02 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:28:02 opera volumio[5023]: info: sendMpdCommand playlistinfo took 1 milliseconds May 15 12:28:02 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:28:02 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:02 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:28:02 opera volumio[5023]: 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":"https://aqqmusic.tc.qq.com/F00000208O1D1gKIZ0.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=AEC97AE471BAF6D9FBF5B988361CFA125CB57241D5F2DD0DE5FD192FB80120612F68034DDAD20EE78FC3C2D501354139E4283EE9218B7DB3__v21ea05af1&uin=1152921504724187376&redirect=1&fromtag=111114","trackType":""} May 15 12:28:02 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::syncState stateService stop May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus play May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::play index undefined May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:02 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:02 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:28:02 opera volumio[5023]: info: ------------------------------ 26ms May 15 12:28:02 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:02 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:28:02 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:28:02 opera volumio[5023]: info: Clearing queue after UPNP request May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::ClearQueue May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::stop May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:28:02 opera volumio[5023]: verbose: UNSET VOLATILE May 15 12:28:02 opera volumio[5023]: info: CorePlayQueue::clearPlayQueue May 15 12:28:02 opera volumio[5023]: info: CorePlayQueue::saveQueue May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::volumioPushQueue May 15 12:28:02 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:02 opera volumio[5023]: info: May 15 12:28:02 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:02 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:02 opera volumio[5023]: error: updateQueue error: null May 15 12:28:02 opera volumio[5023]: info: ------------------------------ 2ms May 15 12:28:02 opera volumio[5023]: info: Starting UPNP Playback May 15 12:28:02 opera volumio[5023]: info: Preparing playback through UPNP May 15 12:28:02 opera volumio[5023]: info: CoreCommandRouter::volumioGetState May 15 12:28:02 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:28:02 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService mpd May 15 12:28:03 opera volumio[5023]: info: May 15 12:28:03 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:03 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:03 opera volumio[5023]: info: May 15 12:28:03 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:03 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:03 opera volumio[5023]: info: ------------------------------ 2ms May 15 12:28:03 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:03 opera volumio[5023]: info: May 15 12:28:03 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:03 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:03 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:03 opera volumio[5023]: info: May 15 12:28:03 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:03 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:03 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:03 opera volumio[5023]: info: May 15 12:28:03 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:03 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:03 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:03 opera volumio[5023]: info: May 15 12:28:03 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:03 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:03 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:04 opera volumio[5023]: info: May 15 12:28:04 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:28:04 opera volumio[5023]: info: ControllerMpd::getState May 15 12:28:04 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:28:04 opera volumio[5023]: info: May 15 12:28:04 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:28:04 opera volumio[5023]: info: sendMpdCommand status took 123 milliseconds May 15 12:28:04 opera volumio[5023]: info: ControllerMpd::getState May 15 12:28:04 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:28:04 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:28:04 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:28:04 opera volumio[5023]: info: May 15 12:28:04 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:04 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:04 opera volumio[5023]: info: sendMpdCommand status took 3 milliseconds May 15 12:28:04 opera volumio[5023]: info: sendMpdCommand playlistinfo took 2 milliseconds May 15 12:28:04 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:28:04 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:28:04 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:28:04 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:28:04 opera volumio[5023]: verbose: In UPNP mode May 15 12:28:04 opera volumio[5023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天涯歌女 吴侬软语版","artist":"林清弄","album":"天涯歌女 吴侬软语版","uri":"https://aqqmusic.tc.qq.com/F000000YgPHA05GZhB.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=14CA8DBFEA22089E421A960D5D173EF798171F94BA963D6564C10B7FD51AF4121230CF7B0CF8C7FB0C1395C9A829E4CD20344A4B7B0C8AAE__v21530b759&uin=1152921504724187376&redirect=1&fromtag=111114","trackType":""} May 15 12:28:04 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::syncState stateService play May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus stop May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:04 opera volumio[5023]: info: ------------------------------ 137ms May 15 12:28:04 opera volumio[5023]: info: ------------------------------ 12ms May 15 12:28:04 opera volumio[5023]: info: sendMpdCommand playlistinfo took 10 milliseconds May 15 12:28:04 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:28:04 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:28:04 opera volumio[5023]: verbose: In UPNP mode May 15 12:28:04 opera volumio[5023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":170,"duration":235,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"831 Kbps","isStreaming":false,"title":"天涯歌女 吴侬软语版","artist":"林清弄","album":"天涯歌女 吴侬软语版","uri":"https://aqqmusic.tc.qq.com/F000000YgPHA05GZhB.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=14CA8DBFEA22089E421A960D5D173EF798171F94BA963D6564C10B7FD51AF4121230CF7B0CF8C7FB0C1395C9A829E4CD20344A4B7B0C8AAE__v21530b759&uin=1152921504724187376&redirect=1&fromtag=111114","trackType":""} May 15 12:28:04 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::syncState stateService play May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus play May 15 12:28:04 opera volumio[5023]: info: Received an update from plugin. extracting info from payload May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:04 opera volumio[5023]: info: ------------------------------ 31ms May 15 12:28:04 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:04 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:04 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:28:04 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:28:04 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:28:04 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:28:04 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:28:05 opera volumio[5023]: info: May 15 12:28:05 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:28:05 opera volumio[5023]: info: ControllerMpd::getState May 15 12:28:05 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:28:05 opera volumio[5023]: info: sendMpdCommand status took 0 milliseconds May 15 12:28:05 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:28:05 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:28:05 opera volumio[5023]: info: sendMpdCommand playlistinfo took 0 milliseconds May 15 12:28:05 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:28:05 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:28:05 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:28:05 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:05 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:05 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:05 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:28:05 opera volumio[5023]: 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":"https://aqqmusic.tc.qq.com/F000000YgPHA05GZhB.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=14CA8DBFEA22089E421A960D5D173EF798171F94BA963D6564C10B7FD51AF4121230CF7B0CF8C7FB0C1395C9A829E4CD20344A4B7B0C8AAE__v21530b759&uin=1152921504724187376&redirect=1&fromtag=111114","trackType":""} May 15 12:28:05 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:28:05 opera volumio[5023]: info: CoreStateMachine::syncState stateService stop May 15 12:28:05 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus play May 15 12:28:05 opera volumio[5023]: info: CoreStateMachine::play index undefined May 15 12:28:05 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:28:05 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:05 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:28:05 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:05 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:05 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:28:05 opera volumio[5023]: info: ------------------------------ 15ms May 15 12:28:05 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:05 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:05 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:28:05 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:28:05 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:28:06 opera volumio[5023]: info: Clearing queue after UPNP request May 15 12:28:06 opera volumio[5023]: info: CoreStateMachine::ClearQueue May 15 12:28:06 opera volumio[5023]: info: CoreStateMachine::stop May 15 12:28:06 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 12:28:06 opera volumio[5023]: verbose: UNSET VOLATILE May 15 12:28:06 opera volumio[5023]: info: CorePlayQueue::clearPlayQueue May 15 12:28:06 opera volumio[5023]: info: CorePlayQueue::saveQueue May 15 12:28:06 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:06 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:06 opera volumio[5023]: info: CoreCommandRouter::volumioPushQueue May 15 12:28:06 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:06 opera volumio[5023]: info: May 15 12:28:06 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:06 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:06 opera volumio[5023]: error: updateQueue error: null May 15 12:28:06 opera volumio[5023]: info: ------------------------------ 2ms May 15 12:28:06 opera volumio[5023]: info: Starting UPNP Playback May 15 12:28:06 opera volumio[5023]: info: Preparing playback through UPNP May 15 12:28:06 opera volumio[5023]: info: CoreCommandRouter::volumioGetState May 15 12:28:06 opera volumio[5023]: info: CorePlayQueue::getTrack 0 May 15 12:28:06 opera volumio[5023]: info: CoreStateMachine::setConsumeUpdateService mpd May 15 12:28:06 opera volumio[5023]: info: May 15 12:28:06 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:06 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:06 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:06 opera volumio[5023]: info: May 15 12:28:06 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:06 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:06 opera volumio[5023]: info: May 15 12:28:06 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:06 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:06 opera volumio[5023]: info: ------------------------------ 2ms May 15 12:28:06 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:06 opera volumio[5023]: info: May 15 12:28:06 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:06 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:06 opera volumio[5023]: info: May 15 12:28:06 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:06 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:06 opera volumio[5023]: info: ------------------------------ 2ms May 15 12:28:06 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:06 opera volumio[5023]: info: May 15 12:28:06 opera volumio[5023]: ---------------------------- MPD announces system playlist update May 15 12:28:06 opera volumio[5023]: info: Ignoring MPD Status Update May 15 12:28:06 opera volumio[5023]: info: ------------------------------ 1ms May 15 12:28:08 opera volumio[5023]: info: May 15 12:28:08 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:28:08 opera volumio[5023]: info: ControllerMpd::getState May 15 12:28:08 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:28:08 opera volumio[5023]: info: sendMpdCommand status took 122 milliseconds May 15 12:28:08 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:28:08 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:28:08 opera volumio[5023]: info: May 15 12:28:08 opera volumio[5023]: ---------------------------- MPD announces state update: player May 15 12:28:08 opera volumio[5023]: info: ControllerMpd::getState May 15 12:28:08 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand status May 15 12:28:08 opera volumio[5023]: info: sendMpdCommand playlistinfo took 2 milliseconds May 15 12:28:08 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:28:08 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:28:08 opera volumio[5023]: verbose: In UPNP mode May 15 12:28:08 opera volumio[5023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":360,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"羚羊过山岗","artist":"朱哲琴","album":"阿姐鼓 (8周年回馈珍藏版)","uri":"https://aqqmusic.tc.qq.com/F000001ElmIf2f8A4Q.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=BABACD60BE6AEF206C54A9C598A639844EF2A37EB45BFE62D1156A43907C07B59CB94719FB24D6211850AC3351B3BC77B3C3BF96D468F980__v21ea05af1&uin=1152921504724187376&src=F000002g3Lh92wZWNV.flac&redirect=1&fromtag=111114","trackType":""} May 15 12:28:08 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::syncState stateService play May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus stop May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:08 opera volumio[5023]: info: ------------------------------ 150ms May 15 12:28:08 opera volumio[5023]: info: sendMpdCommand status took 26 milliseconds May 15 12:28:08 opera volumio[5023]: verbose: ControllerMpd::parseState May 15 12:28:08 opera volumio[5023]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 12:28:08 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:08 opera volumio[5023]: info: sendMpdCommand playlistinfo took 5 milliseconds May 15 12:28:08 opera volumio[5023]: verbose: ControllerMpd::parseTrackInfo May 15 12:28:08 opera volumio[5023]: info: ControllerMpd::pushState May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::servicePushState May 15 12:28:08 opera volumio[5023]: verbose: In UPNP mode May 15 12:28:08 opera volumio[5023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":360,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"羚羊过山岗","artist":"朱哲琴","album":"阿姐鼓 (8周年回馈珍藏版)","uri":"https://aqqmusic.tc.qq.com/F000001ElmIf2f8A4Q.flac?guid=ffffffff940390ae0000018aef37fd87&vkey=BABACD60BE6AEF206C54A9C598A639844EF2A37EB45BFE62D1156A43907C07B59CB94719FB24D6211850AC3351B3BC77B3C3BF96D468F980__v21ea05af1&uin=1152921504724187376&src=F000002g3Lh92wZWNV.flac&redirect=1&fromtag=111114","trackType":""} May 15 12:28:08 opera volumio[5023]: verbose: CURRENT POSITION 0 May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::syncState stateService play May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::syncState currentStatus play May 15 12:28:08 opera volumio[5023]: info: Received an update from plugin. extracting info from payload May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::pushState May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::volumioPushState May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 12:28:08 opera volumio[5023]: info: ------------------------------ 49ms May 15 12:28:08 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:08 opera volumio[5023]: info: Updating RAAT Signal Path May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:28:08 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:28:08 opera volumio[5023]: info: CoreCommandRouter::volumioGetQueue May 15 12:28:08 opera volumio[5023]: info: CoreStateMachine::getQueue May 15 12:28:08 opera volumio[5023]: info: CorePlayQueue::getQueue May 15 12:28:26 opera volumio[5023]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 12:28:26 opera volumio[5023]: { Error: connect ETIMEDOUT 202.160.128.205:443 May 15 12:28:26 opera volumio[5023]: at Object._errnoException (util.js:1022:11) May 15 12:28:26 opera volumio[5023]: at _exceptionWithHostPort (util.js:1044:20) May 15 12:28:26 opera volumio[5023]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 15 12:28:26 opera volumio[5023]: code: 'ETIMEDOUT', May 15 12:28:26 opera volumio[5023]: errno: 'ETIMEDOUT', May 15 12:28:26 opera volumio[5023]: syscall: 'connect', May 15 12:28:26 opera volumio[5023]: address: '202.160.128.205', May 15 12:28:26 opera volumio[5023]: port: 443 } May 15 12:28:26 opera volumio[5023]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 12:28:26 opera sudo[6395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-15 12:27 May 15 12:28:26 opera sudo[6395]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"