-- Logs begin at Fri 2024-07-12 07:45:05 UTC, end at Mon 2025-03-03 13:01:31 UTC. -- Mar 03 13:00:20 opera volumio[9138]: info: Mar 03 13:00:20 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:20 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:20 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:20 opera volumio[9138]: info: sendMpdCommand status took 1 milliseconds Mar 03 13:00:20 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:20 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:20 opera volumio[9138]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 03 13:00:20 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:20 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:20 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:20 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:20 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:20 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:20 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:20 opera volumio[9138]: 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":"Anniversary Song","artist":"Fere Scheidegger","album":"Fere Scheidegger & his anniversary band","uri":"http://aqqmusic.tc.qq.com/F000004KxS5v4aQ8Ra.flac?guid=000000005b56b722000001937137c5ff&vkey=4DB3FA1A283EBCC46E7155E4673C868EC46B4E7FA364045CA609A813B69C93418747C8A657EBD048EDBCEECEC246CBC5325111183CA81801__v2b9ab994&uin=1152921504950983260&src=F000004fBqcm07N8aH.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:20 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:20 opera volumio[9138]: info: CoreStateMachine::syncState stateService stop Mar 03 13:00:20 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:20 opera volumio[9138]: info: CoreStateMachine::play index undefined Mar 03 13:00:20 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:20 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:20 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:20 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:20 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:20 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:20 opera volumio[9138]: info: ------------------------------ 20ms Mar 03 13:00:20 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:20 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:20 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:20 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:20 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:20 opera volumio[9138]: info: Clearing queue after UPNP request Mar 03 13:00:21 opera volumio[9138]: info: CoreStateMachine::ClearQueue Mar 03 13:00:21 opera volumio[9138]: info: CoreStateMachine::stop Mar 03 13:00:21 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:21 opera volumio[9138]: verbose: UNSET VOLATILE Mar 03 13:00:21 opera volumio[9138]: info: CorePlayQueue::clearPlayQueue Mar 03 13:00:21 opera volumio[9138]: info: CorePlayQueue::saveQueue Mar 03 13:00:21 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:21 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:21 opera volumio[9138]: info: CoreCommandRouter::volumioPushQueue Mar 03 13:00:21 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:21 opera volumio[9138]: info: Mar 03 13:00:21 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:21 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:21 opera volumio[9138]: error: updateQueue error: null Mar 03 13:00:21 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:21 opera volumio[9138]: info: Starting UPNP Playback Mar 03 13:00:21 opera volumio[9138]: info: Preparing playback through UPNP Mar 03 13:00:21 opera volumio[9138]: info: CoreCommandRouter::volumioGetState Mar 03 13:00:21 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:21 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 03 13:00:21 opera volumio[9138]: info: Mar 03 13:00:21 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:21 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:21 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:21 opera volumio[9138]: info: Mar 03 13:00:21 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:21 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:21 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:21 opera volumio[9138]: info: Mar 03 13:00:21 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:21 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:21 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:21 opera volumio[9138]: info: Mar 03 13:00:21 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:21 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:21 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:21 opera volumio[9138]: info: Mar 03 13:00:21 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:21 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:21 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:21 opera volumio[9138]: info: Mar 03 13:00:21 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:21 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:21 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:22 opera volumio[9138]: info: Mar 03 13:00:22 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:22 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:22 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:22 opera volumio[9138]: info: Mar 03 13:00:22 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:22 opera volumio[9138]: info: sendMpdCommand status took 2 milliseconds Mar 03 13:00:22 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:22 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:22 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:22 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:22 opera volumio[9138]: info: sendMpdCommand status took 2 milliseconds Mar 03 13:00:22 opera volumio[9138]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 13:00:22 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:22 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:22 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:22 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:22 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:00:22 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song","artist":"Django Reinhardt","album":"Memorial","uri":"http://aqqmusic.tc.qq.com/F000003UuMtk1oCrTl.flac?guid=000000005b56b722000001937137c5ff&vkey=94B8D5E3A48D73FD8CB418E1F404AF83297EC99924F3A1C2B08A2B4330FBF43E4B878C6F4E566BBF56ED42A1696AAE889A2624D13278D464__v2b9ab994&uin=1152921504950983260&src=F000002wUyRt4eMVfy.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:22 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus stop Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:22 opera volumio[9138]: info: ------------------------------ 13ms Mar 03 13:00:22 opera volumio[9138]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 03 13:00:22 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:22 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:22 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:00:22 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song","artist":"Django Reinhardt","album":"Memorial","uri":"http://aqqmusic.tc.qq.com/F000003UuMtk1oCrTl.flac?guid=000000005b56b722000001937137c5ff&vkey=94B8D5E3A48D73FD8CB418E1F404AF83297EC99924F3A1C2B08A2B4330FBF43E4B878C6F4E566BBF56ED42A1696AAE889A2624D13278D464__v2b9ab994&uin=1152921504950983260&src=F000002wUyRt4eMVfy.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:22 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:22 opera volumio[9138]: info: Received an update from plugin. extracting info from payload Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:22 opera volumio[9138]: info: ------------------------------ 26ms Mar 03 13:00:22 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:22 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:22 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:22 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:22 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:22 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:22 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:35 opera volumio[9138]: info: Mar 03 13:00:35 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:35 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:35 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:35 opera volumio[9138]: info: sendMpdCommand status took 1 milliseconds Mar 03 13:00:35 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:35 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:35 opera volumio[9138]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 13:00:35 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:35 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:35 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:35 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:35 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:35 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:35 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:35 opera volumio[9138]: 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":"Anniversary Song","artist":"Django Reinhardt","album":"Memorial","uri":"http://aqqmusic.tc.qq.com/F000003UuMtk1oCrTl.flac?guid=000000005b56b722000001937137c5ff&vkey=94B8D5E3A48D73FD8CB418E1F404AF83297EC99924F3A1C2B08A2B4330FBF43E4B878C6F4E566BBF56ED42A1696AAE889A2624D13278D464__v2b9ab994&uin=1152921504950983260&src=F000002wUyRt4eMVfy.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:35 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:35 opera volumio[9138]: info: CoreStateMachine::syncState stateService stop Mar 03 13:00:35 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:35 opera volumio[9138]: info: CoreStateMachine::play index undefined Mar 03 13:00:35 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:35 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:35 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:35 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:35 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:35 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:35 opera volumio[9138]: info: ------------------------------ 22ms Mar 03 13:00:35 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:35 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:35 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:35 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:35 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:36 opera volumio[9138]: info: Clearing queue after UPNP request Mar 03 13:00:36 opera volumio[9138]: info: CoreStateMachine::ClearQueue Mar 03 13:00:36 opera volumio[9138]: info: CoreStateMachine::stop Mar 03 13:00:36 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:36 opera volumio[9138]: verbose: UNSET VOLATILE Mar 03 13:00:36 opera volumio[9138]: info: CorePlayQueue::clearPlayQueue Mar 03 13:00:36 opera volumio[9138]: info: CorePlayQueue::saveQueue Mar 03 13:00:36 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:36 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:36 opera volumio[9138]: info: CoreCommandRouter::volumioPushQueue Mar 03 13:00:36 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:36 opera volumio[9138]: info: Mar 03 13:00:36 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:36 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:36 opera volumio[9138]: error: updateQueue error: null Mar 03 13:00:36 opera volumio[9138]: info: ------------------------------ 2ms Mar 03 13:00:36 opera volumio[9138]: info: Starting UPNP Playback Mar 03 13:00:36 opera volumio[9138]: info: Preparing playback through UPNP Mar 03 13:00:36 opera volumio[9138]: info: CoreCommandRouter::volumioGetState Mar 03 13:00:36 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:36 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 03 13:00:36 opera volumio[9138]: info: Mar 03 13:00:36 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:36 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:36 opera volumio[9138]: info: Mar 03 13:00:36 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:36 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:36 opera volumio[9138]: info: ------------------------------ 2ms Mar 03 13:00:36 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:36 opera volumio[9138]: info: Mar 03 13:00:36 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:36 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:36 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:36 opera volumio[9138]: info: Mar 03 13:00:36 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:36 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:36 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:36 opera volumio[9138]: info: Mar 03 13:00:36 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:36 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:36 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:36 opera volumio[9138]: info: Mar 03 13:00:36 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:36 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:36 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:37 opera volumio[9138]: info: Mar 03 13:00:37 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:37 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:37 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:37 opera volumio[9138]: info: Mar 03 13:00:37 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:37 opera volumio[9138]: info: sendMpdCommand status took 2 milliseconds Mar 03 13:00:37 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:37 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:37 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:37 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:37 opera volumio[9138]: info: Mar 03 13:00:37 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:37 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:37 opera volumio[9138]: info: sendMpdCommand status took 2 milliseconds Mar 03 13:00:37 opera volumio[9138]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 13:00:37 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:37 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:37 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:37 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:37 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:00:37 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"394 Kbps","isStreaming":false,"title":"Anniversary Song","artist":"Django Reinhardt","album":"Django Reinhardt in Paris","uri":"http://aqqmusic.tc.qq.com/F000004HrK2S0vShn2.flac?guid=000000005b56b722000001937137c5ff&vkey=1F4D7E887850F8E29CD40B08359C41D1502960F94C00028697E34E9B38C101FE78D3C9CBC2C4B12A2F0D9E807923CB3D30FB07C30F401A9C__v2b9aaf9b&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:37 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus stop Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:37 opera volumio[9138]: info: ------------------------------ 13ms Mar 03 13:00:37 opera volumio[9138]: info: ------------------------------ 11ms Mar 03 13:00:37 opera volumio[9138]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 03 13:00:37 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:37 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:37 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:00:37 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"385 Kbps","isStreaming":false,"title":"Anniversary Song","artist":"Django Reinhardt","album":"Django Reinhardt in Paris","uri":"http://aqqmusic.tc.qq.com/F000004HrK2S0vShn2.flac?guid=000000005b56b722000001937137c5ff&vkey=1F4D7E887850F8E29CD40B08359C41D1502960F94C00028697E34E9B38C101FE78D3C9CBC2C4B12A2F0D9E807923CB3D30FB07C30F401A9C__v2b9aaf9b&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:37 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:37 opera volumio[9138]: info: Received an update from plugin. extracting info from payload Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:37 opera volumio[9138]: info: ------------------------------ 30ms Mar 03 13:00:37 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:37 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:37 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:37 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:37 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:37 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:37 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:37 opera volumio[9138]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Django%20Reinhardt/Memorial/e122aa0f-f73d-41c7-bfbf-43a09ef33fd1.jpg' Mar 03 13:00:44 opera volumio[9138]: info: Mar 03 13:00:44 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:44 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:44 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:44 opera volumio[9138]: info: sendMpdCommand status took 1 milliseconds Mar 03 13:00:44 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:44 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:44 opera volumio[9138]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 13:00:44 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:44 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:44 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:44 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:44 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:44 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:44 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:44 opera volumio[9138]: 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":"Anniversary Song","artist":"Django Reinhardt","album":"Django Reinhardt in Paris","uri":"http://aqqmusic.tc.qq.com/F000004HrK2S0vShn2.flac?guid=000000005b56b722000001937137c5ff&vkey=1F4D7E887850F8E29CD40B08359C41D1502960F94C00028697E34E9B38C101FE78D3C9CBC2C4B12A2F0D9E807923CB3D30FB07C30F401A9C__v2b9aaf9b&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:44 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:44 opera volumio[9138]: info: CoreStateMachine::syncState stateService stop Mar 03 13:00:44 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:44 opera volumio[9138]: info: CoreStateMachine::play index undefined Mar 03 13:00:44 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:44 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:44 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:44 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:44 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:44 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:44 opera volumio[9138]: info: ------------------------------ 20ms Mar 03 13:00:44 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:44 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:44 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:44 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:44 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:45 opera volumio[9138]: info: Clearing queue after UPNP request Mar 03 13:00:45 opera volumio[9138]: info: CoreStateMachine::ClearQueue Mar 03 13:00:45 opera volumio[9138]: info: CoreStateMachine::stop Mar 03 13:00:45 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:45 opera volumio[9138]: verbose: UNSET VOLATILE Mar 03 13:00:45 opera volumio[9138]: info: CorePlayQueue::clearPlayQueue Mar 03 13:00:45 opera volumio[9138]: info: CorePlayQueue::saveQueue Mar 03 13:00:45 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:45 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:45 opera volumio[9138]: info: CoreCommandRouter::volumioPushQueue Mar 03 13:00:45 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:45 opera volumio[9138]: info: Mar 03 13:00:45 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:45 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:45 opera volumio[9138]: error: updateQueue error: null Mar 03 13:00:45 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:45 opera volumio[9138]: info: Starting UPNP Playback Mar 03 13:00:45 opera volumio[9138]: info: Preparing playback through UPNP Mar 03 13:00:45 opera volumio[9138]: info: CoreCommandRouter::volumioGetState Mar 03 13:00:45 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:45 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 03 13:00:46 opera volumio[9138]: info: Mar 03 13:00:46 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:46 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:46 opera volumio[9138]: info: Mar 03 13:00:46 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:46 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:46 opera volumio[9138]: info: ------------------------------ 2ms Mar 03 13:00:46 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:46 opera volumio[9138]: info: Mar 03 13:00:46 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:46 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:46 opera volumio[9138]: info: Mar 03 13:00:46 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:46 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:46 opera volumio[9138]: info: ------------------------------ 2ms Mar 03 13:00:46 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:46 opera volumio[9138]: info: Mar 03 13:00:46 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:46 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:46 opera volumio[9138]: info: Mar 03 13:00:46 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:46 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:46 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:46 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:47 opera volumio[9138]: info: Mar 03 13:00:47 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:47 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:47 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:47 opera volumio[9138]: info: Mar 03 13:00:47 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:47 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:47 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:47 opera volumio[9138]: info: sendMpdCommand status took 5 milliseconds Mar 03 13:00:47 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:47 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:47 opera volumio[9138]: info: sendMpdCommand status took 7 milliseconds Mar 03 13:00:47 opera volumio[9138]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 03 13:00:47 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:47 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:47 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:47 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:47 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:00:47 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":140,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song(Canción De Aniversario)","artist":"The Four Knights","album":"Vintage Vocal Jazz / Swing Nº 31 - EPs Collectors \"I Get So Lonely\"","uri":"http://aqqmusic.tc.qq.com/F000002nOeyn2zF0B4.flac?guid=000000005b56b722000001937137c5ff&vkey=60FE482E94CF9B7B5E952EDC315ED6DEAF05F875163E5C3DADB6E980F971A38723FE7F9CECD5B23CD21570DD5778F4E732BA7C6D301CEE29__v2b9ab203&uin=1152921504950983260&src=F000001tDr7f44NFSK.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:47 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus stop Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:47 opera volumio[9138]: info: ------------------------------ 37ms Mar 03 13:00:47 opera volumio[9138]: info: sendMpdCommand playlistinfo took 15 milliseconds Mar 03 13:00:47 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:47 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:47 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:00:47 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":140,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song(Canción De Aniversario)","artist":"The Four Knights","album":"Vintage Vocal Jazz / Swing Nº 31 - EPs Collectors \"I Get So Lonely\"","uri":"http://aqqmusic.tc.qq.com/F000002nOeyn2zF0B4.flac?guid=000000005b56b722000001937137c5ff&vkey=60FE482E94CF9B7B5E952EDC315ED6DEAF05F875163E5C3DADB6E980F971A38723FE7F9CECD5B23CD21570DD5778F4E732BA7C6D301CEE29__v2b9ab203&uin=1152921504950983260&src=F000001tDr7f44NFSK.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:47 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:47 opera volumio[9138]: info: Received an update from plugin. extracting info from payload Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:47 opera volumio[9138]: info: ------------------------------ 50ms Mar 03 13:00:47 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:47 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:47 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:47 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:47 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:47 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:47 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:47 opera volumio[9138]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Django%20Reinhardt/Django%20Reinhardt%20in%20Paris/b1a9e13e-f686-4b88-a861-76906a5d51e6.jpg' Mar 03 13:00:54 opera volumio[9138]: info: Mar 03 13:00:54 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:54 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:54 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:54 opera volumio[9138]: info: sendMpdCommand status took 1 milliseconds Mar 03 13:00:54 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:54 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:54 opera volumio[9138]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 13:00:54 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:54 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:54 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:54 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:54 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:54 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:54 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:54 opera volumio[9138]: 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":"Anniversary Song(Canción De Aniversario)","artist":"The Four Knights","album":"Vintage Vocal Jazz / Swing Nº 31 - EPs Collectors \"I Get So Lonely\"","uri":"http://aqqmusic.tc.qq.com/F000002nOeyn2zF0B4.flac?guid=000000005b56b722000001937137c5ff&vkey=60FE482E94CF9B7B5E952EDC315ED6DEAF05F875163E5C3DADB6E980F971A38723FE7F9CECD5B23CD21570DD5778F4E732BA7C6D301CEE29__v2b9ab203&uin=1152921504950983260&src=F000001tDr7f44NFSK.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:54 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:54 opera volumio[9138]: info: CoreStateMachine::syncState stateService stop Mar 03 13:00:54 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:54 opera volumio[9138]: info: CoreStateMachine::play index undefined Mar 03 13:00:54 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:54 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:54 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:54 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:54 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:54 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:54 opera volumio[9138]: info: ------------------------------ 19ms Mar 03 13:00:54 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:54 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:54 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:54 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:54 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:55 opera volumio[9138]: info: Clearing queue after UPNP request Mar 03 13:00:55 opera volumio[9138]: info: CoreStateMachine::ClearQueue Mar 03 13:00:55 opera volumio[9138]: info: CoreStateMachine::stop Mar 03 13:00:55 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:55 opera volumio[9138]: verbose: UNSET VOLATILE Mar 03 13:00:55 opera volumio[9138]: info: CorePlayQueue::clearPlayQueue Mar 03 13:00:55 opera volumio[9138]: info: CorePlayQueue::saveQueue Mar 03 13:00:55 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:55 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:55 opera volumio[9138]: info: CoreCommandRouter::volumioPushQueue Mar 03 13:00:55 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:55 opera volumio[9138]: info: Mar 03 13:00:55 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:55 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:55 opera volumio[9138]: error: updateQueue error: null Mar 03 13:00:55 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:55 opera volumio[9138]: info: Starting UPNP Playback Mar 03 13:00:55 opera volumio[9138]: info: Preparing playback through UPNP Mar 03 13:00:55 opera volumio[9138]: info: CoreCommandRouter::volumioGetState Mar 03 13:00:55 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:55 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:56 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:56 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:56 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:56 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:56 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:56 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:56 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:56 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:56 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:56 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:56 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:56 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:56 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:56 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:56 opera volumio[9138]: info: sendMpdCommand status took 1 milliseconds Mar 03 13:00:56 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:56 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:00:56 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:00:56 opera volumio[9138]: info: Mar 03 13:00:56 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:56 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:56 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:56 opera volumio[9138]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 03 13:00:56 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:56 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:56 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:56 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:00:56 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":201,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song","artist":"Vaughn Monroe","album":"Original Hits: Vaughn Monroe","uri":"http://aqqmusic.tc.qq.com/F000002zprXL2N6mgi.flac?guid=000000005b56b722000001937137c5ff&vkey=15200E2863DFFCC5DAE2D988014711573AECEC77F4E22464F2BD5BEA010F74BE2A4BEA00A0AEE6DFA709C613B5768FC9B7CC55851540B9FA__v2b9ab991&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:56 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:56 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:00:56 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus stop Mar 03 13:00:56 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:56 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:57 opera volumio[9138]: info: ------------------------------ 11ms Mar 03 13:00:57 opera volumio[9138]: info: ------------------------------ 9ms Mar 03 13:00:57 opera volumio[9138]: info: sendMpdCommand status took 8 milliseconds Mar 03 13:00:57 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:57 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:57 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:57 opera volumio[9138]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 03 13:00:57 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:57 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:57 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:00:57 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":201,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"334 Kbps","isStreaming":false,"title":"Anniversary Song","artist":"Vaughn Monroe","album":"Original Hits: Vaughn Monroe","uri":"http://aqqmusic.tc.qq.com/F000002zprXL2N6mgi.flac?guid=000000005b56b722000001937137c5ff&vkey=15200E2863DFFCC5DAE2D988014711573AECEC77F4E22464F2BD5BEA010F74BE2A4BEA00A0AEE6DFA709C613B5768FC9B7CC55851540B9FA__v2b9ab991&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:57 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:57 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:00:57 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:57 opera volumio[9138]: info: Received an update from plugin. extracting info from payload Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 13:00:57 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:57 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:57 opera volumio[9138]: info: ------------------------------ 27ms Mar 03 13:00:57 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:57 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:57 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:57 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:57 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:00:57 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:00:57 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:00:59 opera volumio[9138]: info: Mar 03 13:00:59 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:00:59 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:00:59 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:00:59 opera volumio[9138]: info: sendMpdCommand status took 2 milliseconds Mar 03 13:00:59 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:00:59 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:00:59 opera volumio[9138]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 13:00:59 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:00:59 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:00:59 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:00:59 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:59 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:00:59 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:00:59 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:00:59 opera volumio[9138]: 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":"Anniversary Song","artist":"Vaughn Monroe","album":"Original Hits: Vaughn Monroe","uri":"http://aqqmusic.tc.qq.com/F000002zprXL2N6mgi.flac?guid=000000005b56b722000001937137c5ff&vkey=15200E2863DFFCC5DAE2D988014711573AECEC77F4E22464F2BD5BEA010F74BE2A4BEA00A0AEE6DFA709C613B5768FC9B7CC55851540B9FA__v2b9ab991&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Mar 03 13:00:59 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:00:59 opera volumio[9138]: info: CoreStateMachine::syncState stateService stop Mar 03 13:00:59 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:00:59 opera volumio[9138]: info: CoreStateMachine::play index undefined Mar 03 13:00:59 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:00:59 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:00:59 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:01:00 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:00 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:00 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:01:00 opera volumio[9138]: info: ------------------------------ 17ms Mar 03 13:01:00 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:00 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:00 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:01:00 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:01:00 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:01:00 opera volumio[9138]: info: Clearing queue after UPNP request Mar 03 13:01:01 opera volumio[9138]: info: CoreStateMachine::ClearQueue Mar 03 13:01:01 opera volumio[9138]: info: CoreStateMachine::stop Mar 03 13:01:01 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:01:01 opera volumio[9138]: verbose: UNSET VOLATILE Mar 03 13:01:01 opera volumio[9138]: info: CorePlayQueue::clearPlayQueue Mar 03 13:01:01 opera volumio[9138]: info: CorePlayQueue::saveQueue Mar 03 13:01:01 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:01 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:01 opera volumio[9138]: info: CoreCommandRouter::volumioPushQueue Mar 03 13:01:01 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:01 opera volumio[9138]: info: Mar 03 13:01:01 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:01 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:01 opera volumio[9138]: error: updateQueue error: null Mar 03 13:01:01 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:01 opera volumio[9138]: info: Starting UPNP Playback Mar 03 13:01:01 opera volumio[9138]: info: Preparing playback through UPNP Mar 03 13:01:01 opera volumio[9138]: info: CoreCommandRouter::volumioGetState Mar 03 13:01:01 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:01:01 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 03 13:01:01 opera volumio[9138]: info: Mar 03 13:01:01 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:01 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:01 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:01 opera volumio[9138]: info: Mar 03 13:01:01 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:01 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:01 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:01 opera volumio[9138]: info: Mar 03 13:01:01 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:01 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:01 opera volumio[9138]: info: ------------------------------ 2ms Mar 03 13:01:01 opera volumio[9138]: info: Mar 03 13:01:01 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:01 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:01 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:01 opera volumio[9138]: info: Mar 03 13:01:01 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:01 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:01 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:01 opera volumio[9138]: info: Mar 03 13:01:01 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:01 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:01 opera volumio[9138]: info: ------------------------------ 2ms Mar 03 13:01:04 opera volumio[9138]: info: Mar 03 13:01:04 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:01:04 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:01:04 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:01:04 opera volumio[9138]: info: Mar 03 13:01:04 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:01:04 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:01:04 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:01:04 opera volumio[9138]: info: sendMpdCommand status took 2 milliseconds Mar 03 13:01:04 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:01:04 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:01:04 opera volumio[9138]: info: sendMpdCommand status took 3 milliseconds Mar 03 13:01:04 opera volumio[9138]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 03 13:01:04 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:01:04 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:01:04 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:01:04 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:01:04 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:01:04 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":185,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song","artist":"Vaughn Monroe","album":"Kokomo Indiana","uri":"http://aqqmusic.tc.qq.com/F000002XSoF516rM2x.flac?guid=000000005b56b722000001937137c5ff&vkey=DE27E134032D438275ED8A8856DF30B914081F006003201CE76BFD1F7284D3325756655C1DF023815B6BED090BD66885C719E09D19CCDD84__v2b9ab203&uin=1152921504950983260&src=F000002XSoF516rM2x.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:01:04 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus stop Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:04 opera volumio[9138]: info: ------------------------------ 25ms Mar 03 13:01:04 opera volumio[9138]: info: sendMpdCommand playlistinfo took 18 milliseconds Mar 03 13:01:04 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:01:04 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:01:04 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:01:04 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":185,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song","artist":"Vaughn Monroe","album":"Kokomo Indiana","uri":"http://aqqmusic.tc.qq.com/F000002XSoF516rM2x.flac?guid=000000005b56b722000001937137c5ff&vkey=DE27E134032D438275ED8A8856DF30B914081F006003201CE76BFD1F7284D3325756655C1DF023815B6BED090BD66885C719E09D19CCDD84__v2b9ab203&uin=1152921504950983260&src=F000002XSoF516rM2x.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:01:04 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:01:04 opera volumio[9138]: info: Received an update from plugin. extracting info from payload Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:04 opera volumio[9138]: info: ------------------------------ 42ms Mar 03 13:01:04 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:04 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:04 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:01:04 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:01:04 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:01:04 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:01:04 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:01:04 opera volumio[9138]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vaughn%20Monroe/Original%20Hits%3A%20Vaughn%20Monroe/f1db4cc8-eb4c-4fd6-b1c0-93b5d37b83c8.jpg' Mar 03 13:01:11 opera volumio[9138]: info: Mar 03 13:01:11 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:01:11 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:01:11 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:01:11 opera volumio[9138]: info: sendMpdCommand status took 1 milliseconds Mar 03 13:01:11 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:01:11 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:01:11 opera volumio[9138]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 03 13:01:11 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:01:11 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:01:11 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:01:11 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:01:11 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:11 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:11 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:01:11 opera volumio[9138]: 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":"Anniversary Song","artist":"Vaughn Monroe","album":"Kokomo Indiana","uri":"http://aqqmusic.tc.qq.com/F000002XSoF516rM2x.flac?guid=000000005b56b722000001937137c5ff&vkey=DE27E134032D438275ED8A8856DF30B914081F006003201CE76BFD1F7284D3325756655C1DF023815B6BED090BD66885C719E09D19CCDD84__v2b9ab203&uin=1152921504950983260&src=F000002XSoF516rM2x.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:01:11 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:01:11 opera volumio[9138]: info: CoreStateMachine::syncState stateService stop Mar 03 13:01:11 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:01:11 opera volumio[9138]: info: CoreStateMachine::play index undefined Mar 03 13:01:11 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:01:11 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:01:11 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:01:11 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:11 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:11 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:01:11 opera volumio[9138]: info: ------------------------------ 17ms Mar 03 13:01:11 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:11 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:11 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:01:11 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:01:11 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:01:11 opera volumio[9138]: info: Clearing queue after UPNP request Mar 03 13:01:12 opera volumio[9138]: info: CoreStateMachine::ClearQueue Mar 03 13:01:12 opera volumio[9138]: info: CoreStateMachine::stop Mar 03 13:01:12 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 13:01:12 opera volumio[9138]: verbose: UNSET VOLATILE Mar 03 13:01:12 opera volumio[9138]: info: CorePlayQueue::clearPlayQueue Mar 03 13:01:12 opera volumio[9138]: info: CorePlayQueue::saveQueue Mar 03 13:01:12 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:12 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:12 opera volumio[9138]: info: CoreCommandRouter::volumioPushQueue Mar 03 13:01:12 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:12 opera volumio[9138]: info: Mar 03 13:01:12 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:12 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:12 opera volumio[9138]: error: updateQueue error: null Mar 03 13:01:12 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:12 opera volumio[9138]: info: Starting UPNP Playback Mar 03 13:01:12 opera volumio[9138]: info: Preparing playback through UPNP Mar 03 13:01:12 opera volumio[9138]: info: CoreCommandRouter::volumioGetState Mar 03 13:01:12 opera volumio[9138]: info: CorePlayQueue::getTrack 0 Mar 03 13:01:12 opera volumio[9138]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 03 13:01:12 opera volumio[9138]: info: Mar 03 13:01:12 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:12 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:12 opera volumio[9138]: info: Mar 03 13:01:12 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:12 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:12 opera volumio[9138]: info: ------------------------------ 2ms Mar 03 13:01:12 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:12 opera volumio[9138]: info: Mar 03 13:01:12 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:12 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:12 opera volumio[9138]: info: Mar 03 13:01:12 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:12 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:12 opera volumio[9138]: info: ------------------------------ 2ms Mar 03 13:01:12 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:12 opera volumio[9138]: info: Mar 03 13:01:12 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:12 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:12 opera volumio[9138]: info: Mar 03 13:01:12 opera volumio[9138]: ---------------------------- MPD announces system playlist update Mar 03 13:01:12 opera volumio[9138]: info: Ignoring MPD Status Update Mar 03 13:01:12 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:12 opera volumio[9138]: info: ------------------------------ 1ms Mar 03 13:01:14 opera volumio[9138]: info: Mar 03 13:01:14 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:01:14 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:01:14 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:01:14 opera volumio[9138]: info: sendMpdCommand status took 1 milliseconds Mar 03 13:01:14 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:01:14 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:01:14 opera volumio[9138]: info: Mar 03 13:01:14 opera volumio[9138]: ---------------------------- MPD announces state update: player Mar 03 13:01:14 opera volumio[9138]: info: ControllerMpd::getState Mar 03 13:01:14 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand status Mar 03 13:01:14 opera volumio[9138]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 03 13:01:14 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:01:14 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:01:14 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:01:14 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song","artist":"Filmmusik","album":"Cinema's Best Movie Soundtracks","uri":"http://aqqmusic.tc.qq.com/F0000002t2Hv4T0gU4.flac?guid=000000005b56b722000001937137c5ff&vkey=6A8F5693360C3771851187BDAF1995058BACDA4EFE5715597BB8330268C4E56A45B17F163902FF27B2C3AFB0161EF01CA87DDFE53F28B559__v2b9ab203&uin=1152921504950983260&src=F0000010AQ8y0XcdCE.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:01:14 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus stop Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:14 opera volumio[9138]: info: ------------------------------ 19ms Mar 03 13:01:14 opera volumio[9138]: info: sendMpdCommand status took 16 milliseconds Mar 03 13:01:14 opera volumio[9138]: verbose: ControllerMpd::parseState Mar 03 13:01:14 opera volumio[9138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 13:01:14 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:14 opera volumio[9138]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 03 13:01:14 opera volumio[9138]: verbose: ControllerMpd::parseTrackInfo Mar 03 13:01:14 opera volumio[9138]: info: ControllerMpd::pushState Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::servicePushState Mar 03 13:01:14 opera volumio[9138]: verbose: In UPNP mode Mar 03 13:01:14 opera volumio[9138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anniversary Song","artist":"Filmmusik","album":"Cinema's Best Movie Soundtracks","uri":"http://aqqmusic.tc.qq.com/F0000002t2Hv4T0gU4.flac?guid=000000005b56b722000001937137c5ff&vkey=6A8F5693360C3771851187BDAF1995058BACDA4EFE5715597BB8330268C4E56A45B17F163902FF27B2C3AFB0161EF01CA87DDFE53F28B559__v2b9ab203&uin=1152921504950983260&src=F0000010AQ8y0XcdCE.flac&redirect=1&fromtag=111114","trackType":""} Mar 03 13:01:14 opera volumio[9138]: verbose: CURRENT POSITION 0 Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::syncState stateService play Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::syncState currentStatus play Mar 03 13:01:14 opera volumio[9138]: info: Received an update from plugin. extracting info from payload Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::pushState Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::volumioPushState Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 13:01:14 opera volumio[9138]: info: ------------------------------ 41ms Mar 03 13:01:14 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:14 opera volumio[9138]: info: Updating RAAT Signal Path Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:01:14 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:01:14 opera volumio[9138]: info: CoreCommandRouter::volumioGetQueue Mar 03 13:01:14 opera volumio[9138]: info: CoreStateMachine::getQueue Mar 03 13:01:14 opera volumio[9138]: info: CorePlayQueue::getQueue Mar 03 13:01:30 opera volumio[9138]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 13:01:30 opera volumio[9138]: { Error: connect ETIMEDOUT 208.101.60.87:443 Mar 03 13:01:30 opera volumio[9138]: at Object._errnoException (util.js:1022:11) Mar 03 13:01:30 opera volumio[9138]: at _exceptionWithHostPort (util.js:1044:20) Mar 03 13:01:30 opera volumio[9138]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 03 13:01:30 opera volumio[9138]: code: 'ETIMEDOUT', Mar 03 13:01:30 opera volumio[9138]: errno: 'ETIMEDOUT', Mar 03 13:01:30 opera volumio[9138]: syscall: 'connect', Mar 03 13:01:30 opera volumio[9138]: address: '208.101.60.87', Mar 03 13:01:30 opera volumio[9138]: port: 443 } Mar 03 13:01:30 opera volumio[9138]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 13:01:31 opera sudo[9997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-03 13:00 Mar 03 13:01:31 opera sudo[9997]: 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"