-- Logs begin at Fri 2024-07-12 07:45:05 UTC, end at Thu 2025-09-11 14:13:45 UTC. -- Sep 11 14:12:47 opera volumio[25776]: info: Sep 11 14:12:47 opera volumio[25776]: ---------------------------- MPD announces state update: player Sep 11 14:12:47 opera volumio[25776]: info: ControllerMpd::getState Sep 11 14:12:47 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:12:47 opera volumio[25776]: info: sendMpdCommand status took 2 milliseconds Sep 11 14:12:47 opera volumio[25776]: verbose: ControllerMpd::parseState Sep 11 14:12:47 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:12:47 opera volumio[25776]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 11 14:12:47 opera volumio[25776]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:12:47 opera volumio[25776]: info: ControllerMpd::pushState Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::servicePushState Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:12:47 opera volumio[25776]: info: CorePlayQueue::getTrack 0 Sep 11 14:12:47 opera volumio[25776]: 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":"Emmanuel","artist":"Chris Botti","album":"Valentine's Sampler","uri":"http://aqqmusic.tc.qq.com/M800001LKlBE3tSO9c.mp3?guid=000000005b56b722000001937137c5ff&vkey=CBE4F2470DFF36D317615D2AC27C2E9C5E34CCE65AA0CDB4D7150664F5845644011BEE03529421334AAD9C8AF867A5455E545829F8ED29A3__v2b94c60d&uin=1152921504950983260&src=M8000000Kf2k4c4f9E.mp3&redirect=1&fromtag=111093","trackType":""} Sep 11 14:12:47 opera volumio[25776]: verbose: CURRENT POSITION 0 Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::syncState stateService stop Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::play index undefined Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:12:47 opera volumio[25776]: info: CorePlayQueue::getTrack 0 Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:12:47 opera volumio[25776]: info: CorePlayQueue::getTrack 0 Sep 11 14:12:47 opera volumio[25776]: info: ------------------------------ 25ms Sep 11 14:12:47 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:12:47 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::getQueue Sep 11 14:12:47 opera volumio[25776]: info: CorePlayQueue::getQueue Sep 11 14:12:47 opera volumio[25776]: info: Clearing queue after UPNP request Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::ClearQueue Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::stop Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 14:12:47 opera volumio[25776]: verbose: UNSET VOLATILE Sep 11 14:12:47 opera volumio[25776]: info: CorePlayQueue::clearPlayQueue Sep 11 14:12:47 opera volumio[25776]: info: CorePlayQueue::saveQueue Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::volumioPushQueue Sep 11 14:12:47 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:12:47 opera volumio[25776]: info: Sep 11 14:12:47 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:12:47 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:12:47 opera volumio[25776]: error: updateQueue error: null Sep 11 14:12:47 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:12:47 opera volumio[25776]: info: Starting UPNP Playback Sep 11 14:12:47 opera volumio[25776]: info: Preparing playback through UPNP Sep 11 14:12:47 opera volumio[25776]: info: CoreCommandRouter::volumioGetState Sep 11 14:12:47 opera volumio[25776]: info: CorePlayQueue::getTrack 0 Sep 11 14:12:47 opera volumio[25776]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:12:48 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:12:48 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 2ms Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 2ms Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:12:48 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:12:48 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:12:48 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:12:48 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces state update: player Sep 11 14:12:48 opera volumio[25776]: info: ControllerMpd::getState Sep 11 14:12:48 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces state update: player Sep 11 14:12:48 opera volumio[25776]: info: sendMpdCommand status took 2 milliseconds Sep 11 14:12:48 opera volumio[25776]: info: ControllerMpd::getState Sep 11 14:12:48 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:12:48 opera volumio[25776]: verbose: ControllerMpd::parseState Sep 11 14:12:48 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:12:48 opera volumio[25776]: info: Sep 11 14:12:48 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:12:48 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:12:48 opera volumio[25776]: info: sendMpdCommand status took 2 milliseconds Sep 11 14:12:48 opera volumio[25776]: verbose: ControllerMpd::parseState Sep 11 14:12:48 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:12:48 opera volumio[25776]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 2ms Sep 11 14:12:48 opera volumio[25776]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:12:48 opera volumio[25776]: info: ControllerMpd::pushState Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::servicePushState Sep 11 14:12:48 opera volumio[25776]: verbose: In UPNP mode Sep 11 14:12:48 opera volumio[25776]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":318,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Emmanuel","artist":"Chris Botti","album":"Valentine's Sampler","uri":"http://aqqmusic.tc.qq.com/M800001LKlBE3tSO9c.mp3?guid=000000005b56b722000001937137c5ff&vkey=CBE4F2470DFF36D317615D2AC27C2E9C5E34CCE65AA0CDB4D7150664F5845644011BEE03529421334AAD9C8AF867A5455E545829F8ED29A3__v2b94c60d&uin=1152921504950983260&src=M8000000Kf2k4c4f9E.mp3&redirect=1&fromtag=111093","trackType":""} Sep 11 14:12:48 opera volumio[25776]: verbose: CURRENT POSITION 0 Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::syncState stateService play Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::syncState currentStatus stop Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 14ms Sep 11 14:12:48 opera volumio[25776]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 11 14:12:48 opera volumio[25776]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:12:48 opera volumio[25776]: info: ControllerMpd::pushState Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::servicePushState Sep 11 14:12:48 opera volumio[25776]: verbose: In UPNP mode Sep 11 14:12:48 opera volumio[25776]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":318,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Emmanuel","artist":"Chris Botti","album":"Valentine's Sampler","uri":"http://aqqmusic.tc.qq.com/M800001LKlBE3tSO9c.mp3?guid=000000005b56b722000001937137c5ff&vkey=CBE4F2470DFF36D317615D2AC27C2E9C5E34CCE65AA0CDB4D7150664F5845644011BEE03529421334AAD9C8AF867A5455E545829F8ED29A3__v2b94c60d&uin=1152921504950983260&src=M8000000Kf2k4c4f9E.mp3&redirect=1&fromtag=111093","trackType":""} Sep 11 14:12:48 opera volumio[25776]: verbose: CURRENT POSITION 0 Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::syncState stateService play Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:12:48 opera volumio[25776]: info: Received an update from plugin. extracting info from payload Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:12:48 opera volumio[25776]: info: ------------------------------ 27ms Sep 11 14:12:48 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:12:48 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:12:48 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::getQueue Sep 11 14:12:48 opera volumio[25776]: info: CorePlayQueue::getQueue Sep 11 14:12:48 opera volumio[25776]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:12:48 opera volumio[25776]: info: CoreStateMachine::getQueue Sep 11 14:12:48 opera volumio[25776]: info: CorePlayQueue::getQueue Sep 11 14:13:11 opera volumio[25776]: info: Sep 11 14:13:11 opera volumio[25776]: ---------------------------- MPD announces state update: player Sep 11 14:13:11 opera volumio[25776]: info: ControllerMpd::getState Sep 11 14:13:11 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:13:11 opera volumio[25776]: info: sendMpdCommand status took 2 milliseconds Sep 11 14:13:11 opera volumio[25776]: verbose: ControllerMpd::parseState Sep 11 14:13:11 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:13:11 opera volumio[25776]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 11 14:13:11 opera volumio[25776]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:13:11 opera volumio[25776]: info: ControllerMpd::pushState Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::servicePushState Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:13:11 opera volumio[25776]: info: CorePlayQueue::getTrack 0 Sep 11 14:13:11 opera volumio[25776]: 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":"Emmanuel","artist":"Chris Botti","album":"Valentine's Sampler","uri":"http://aqqmusic.tc.qq.com/M800001LKlBE3tSO9c.mp3?guid=000000005b56b722000001937137c5ff&vkey=CBE4F2470DFF36D317615D2AC27C2E9C5E34CCE65AA0CDB4D7150664F5845644011BEE03529421334AAD9C8AF867A5455E545829F8ED29A3__v2b94c60d&uin=1152921504950983260&src=M8000000Kf2k4c4f9E.mp3&redirect=1&fromtag=111093","trackType":""} Sep 11 14:13:11 opera volumio[25776]: verbose: CURRENT POSITION 0 Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::syncState stateService stop Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::play index undefined Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:13:11 opera volumio[25776]: info: CorePlayQueue::getTrack 0 Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:13:11 opera volumio[25776]: info: CorePlayQueue::getTrack 0 Sep 11 14:13:11 opera volumio[25776]: info: ------------------------------ 24ms Sep 11 14:13:11 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:13:11 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::getQueue Sep 11 14:13:11 opera volumio[25776]: info: CorePlayQueue::getQueue Sep 11 14:13:11 opera volumio[25776]: info: Clearing queue after UPNP request Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::ClearQueue Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::stop Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 11 14:13:11 opera volumio[25776]: verbose: UNSET VOLATILE Sep 11 14:13:11 opera volumio[25776]: info: CorePlayQueue::clearPlayQueue Sep 11 14:13:11 opera volumio[25776]: info: CorePlayQueue::saveQueue Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::volumioPushQueue Sep 11 14:13:11 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:13:11 opera volumio[25776]: info: Sep 11 14:13:11 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:13:11 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:13:11 opera volumio[25776]: error: updateQueue error: null Sep 11 14:13:11 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:13:11 opera volumio[25776]: info: Starting UPNP Playback Sep 11 14:13:11 opera volumio[25776]: info: Preparing playback through UPNP Sep 11 14:13:11 opera volumio[25776]: info: CoreCommandRouter::volumioGetState Sep 11 14:13:11 opera volumio[25776]: info: CorePlayQueue::getTrack 0 Sep 11 14:13:11 opera volumio[25776]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 11 14:13:12 opera volumio[25776]: info: Sep 11 14:13:12 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:13:12 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:13:12 opera volumio[25776]: info: Sep 11 14:13:12 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:13:12 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:13:12 opera volumio[25776]: info: ------------------------------ 2ms Sep 11 14:13:12 opera volumio[25776]: info: ------------------------------ 2ms Sep 11 14:13:12 opera volumio[25776]: info: Sep 11 14:13:12 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:13:12 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:13:12 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:13:12 opera volumio[25776]: info: Sep 11 14:13:12 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:13:12 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:13:12 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:13:12 opera volumio[25776]: info: Sep 11 14:13:12 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:13:12 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:13:12 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:13:12 opera volumio[25776]: info: Sep 11 14:13:12 opera volumio[25776]: ---------------------------- MPD announces system playlist update Sep 11 14:13:12 opera volumio[25776]: info: Ignoring MPD Status Update Sep 11 14:13:12 opera volumio[25776]: info: ------------------------------ 1ms Sep 11 14:13:13 opera volumio[25776]: info: Sep 11 14:13:13 opera volumio[25776]: ---------------------------- MPD announces state update: player Sep 11 14:13:13 opera volumio[25776]: info: ControllerMpd::getState Sep 11 14:13:13 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:13:13 opera volumio[25776]: info: sendMpdCommand status took 4 milliseconds Sep 11 14:13:13 opera volumio[25776]: verbose: ControllerMpd::parseState Sep 11 14:13:13 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:13:13 opera volumio[25776]: info: Sep 11 14:13:13 opera volumio[25776]: ---------------------------- MPD announces state update: player Sep 11 14:13:13 opera volumio[25776]: info: ControllerMpd::getState Sep 11 14:13:13 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand status Sep 11 14:13:13 opera volumio[25776]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 11 14:13:13 opera volumio[25776]: info: sendMpdCommand status took 1 milliseconds Sep 11 14:13:13 opera volumio[25776]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:13:13 opera volumio[25776]: verbose: ControllerMpd::parseState Sep 11 14:13:13 opera volumio[25776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 11 14:13:13 opera volumio[25776]: info: ControllerMpd::pushState Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::servicePushState Sep 11 14:13:13 opera volumio[25776]: verbose: In UPNP mode Sep 11 14:13:13 opera volumio[25776]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":324,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vision Quest","artist":"Edelis","album":"Vision Quest","uri":"http://aqqmusic.tc.qq.com/F000000RUZq53ap9YV.flac?guid=000000005b56b722000001937137c5ff&vkey=5C6AE7B6A084155D1FA6D8642A5CACD8340CF5E3B1689940B241571192EC830E3142DC91D2AA32D97C96318EE500E9C39ED36D7AFA29D59B__v2b94c60b&uin=1152921504950983260&src=F000003fVo8D2Ge5FB.flac&redirect=1&fromtag=111114","trackType":""} Sep 11 14:13:13 opera volumio[25776]: verbose: CURRENT POSITION 0 Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::syncState stateService play Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::syncState currentStatus stop Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:13:13 opera volumio[25776]: info: ------------------------------ 23ms Sep 11 14:13:13 opera volumio[25776]: info: sendMpdCommand playlistinfo took 14 milliseconds Sep 11 14:13:13 opera volumio[25776]: verbose: ControllerMpd::parseTrackInfo Sep 11 14:13:13 opera volumio[25776]: info: ControllerMpd::pushState Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::servicePushState Sep 11 14:13:13 opera volumio[25776]: verbose: In UPNP mode Sep 11 14:13:13 opera volumio[25776]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":324,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vision Quest","artist":"Edelis","album":"Vision Quest","uri":"http://aqqmusic.tc.qq.com/F000000RUZq53ap9YV.flac?guid=000000005b56b722000001937137c5ff&vkey=5C6AE7B6A084155D1FA6D8642A5CACD8340CF5E3B1689940B241571192EC830E3142DC91D2AA32D97C96318EE500E9C39ED36D7AFA29D59B__v2b94c60b&uin=1152921504950983260&src=F000003fVo8D2Ge5FB.flac&redirect=1&fromtag=111114","trackType":""} Sep 11 14:13:13 opera volumio[25776]: verbose: CURRENT POSITION 0 Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::syncState stateService play Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::syncState currentStatus play Sep 11 14:13:13 opera volumio[25776]: info: Received an update from plugin. extracting info from payload Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::pushState Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::volumioPushState Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 11 14:13:13 opera volumio[25776]: info: ------------------------------ 36ms Sep 11 14:13:13 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:13:13 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:13:13 opera volumio[25776]: info: Updating RAAT Signal Path Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::getQueue Sep 11 14:13:13 opera volumio[25776]: info: CorePlayQueue::getQueue Sep 11 14:13:13 opera volumio[25776]: info: CoreCommandRouter::volumioGetQueue Sep 11 14:13:13 opera volumio[25776]: info: CoreStateMachine::getQueue Sep 11 14:13:13 opera volumio[25776]: info: CorePlayQueue::getQueue Sep 11 14:13:13 opera volumio[25776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Edelis/Vision%20Quest/86da2767-06d0-4515-a3f1-349944bdc337.jpg' Sep 11 14:13:45 opera volumio[25776]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 11 14:13:45 opera volumio[25776]: { Error: connect ETIMEDOUT 128.121.146.235:443 Sep 11 14:13:45 opera volumio[25776]: at Object._errnoException (util.js:1022:11) Sep 11 14:13:45 opera volumio[25776]: at _exceptionWithHostPort (util.js:1044:20) Sep 11 14:13:45 opera volumio[25776]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Sep 11 14:13:45 opera volumio[25776]: code: 'ETIMEDOUT', Sep 11 14:13:45 opera volumio[25776]: errno: 'ETIMEDOUT', Sep 11 14:13:45 opera volumio[25776]: syscall: 'connect', Sep 11 14:13:45 opera volumio[25776]: address: '128.121.146.235', Sep 11 14:13:45 opera volumio[25776]: port: 443 } Sep 11 14:13:45 opera volumio[25776]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 11 14:13:45 opera sudo[27810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-11 14:12 Sep 11 14:13:45 opera sudo[27810]: 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"