-- Logs begin at Mon 2024-03-25 15:04:43 UTC, end at Sat 2024-04-20 12:52:19 UTC. -- Apr 20 12:51:20 opera kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=0x08 Apr 20 12:51:20 opera kernel: sd 0:0:0:0: [sda] tag#0 Sense Key : 0x4 [current] [descriptor] Apr 20 12:51:20 opera kernel: sd 0:0:0:0: [sda] tag#0 ASC=0x0 ASCQ=0x0 Apr 20 12:51:20 opera kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0xa1 a1 06 20 00 00 00 00 00 00 e5 00 00 Apr 20 12:51:26 opera volumio[21999]: info: Apr 20 12:51:26 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:26 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:26 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:26 opera volumio[21999]: info: sendMpdCommand status took 1 milliseconds Apr 20 12:51:26 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:26 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:26 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:51:26 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:26 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:26 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:51:26 opera volumio[21999]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":76242,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"伤感的恋人","artist":"黄凯芹","album":"Moody","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M80000382WXd3Piucp.mp3?guid=000000001465bbe0000001784427ee14&vkey=F860CDB197A9020101008CB42D65D2B228988B16D08093ED624C9915B524C7E30455230189293C2BD8D432FCE056D82C5C011D5C4B0AC009&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:51:26 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::syncState stateService pause Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:51:26 opera volumio[21999]: info: ------------------------------ 18ms Apr 20 12:51:26 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:26 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:26 opera volumio[21999]: info: Apr 20 12:51:26 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:26 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:26 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:26 opera volumio[21999]: info: sendMpdCommand status took 1 milliseconds Apr 20 12:51:26 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:26 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:26 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:51:26 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:26 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:26 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:51:26 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":76741,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"伤感的恋人","artist":"黄凯芹","album":"Moody","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M80000382WXd3Piucp.mp3?guid=000000001465bbe0000001784427ee14&vkey=F860CDB197A9020101008CB42D65D2B228988B16D08093ED624C9915B524C7E30455230189293C2BD8D432FCE056D82C5C011D5C4B0AC009&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:51:26 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:51:26 opera volumio[21999]: info: Received an update from plugin. extracting info from payload Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:26 opera volumio[21999]: info: ------------------------------ 13ms Apr 20 12:51:26 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:26 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:26 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:26 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:26 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:26 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:28 opera volumio[21999]: info: Apr 20 12:51:28 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:28 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:28 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:28 opera volumio[21999]: info: sendMpdCommand status took 2 milliseconds Apr 20 12:51:28 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:28 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:28 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:51:28 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:28 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:28 opera volumio[21999]: info: CorePlayQueue::getTrack 0 Apr 20 12:51:28 opera volumio[21999]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"伤感的恋人","artist":"黄凯芹","album":"Moody","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M80000382WXd3Piucp.mp3?guid=000000001465bbe0000001784427ee14&vkey=F860CDB197A9020101008CB42D65D2B228988B16D08093ED624C9915B524C7E30455230189293C2BD8D432FCE056D82C5C011D5C4B0AC009&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:51:28 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::syncState stateService stop Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:51:28 opera volumio[21999]: info: ------------------------------ 16ms Apr 20 12:51:28 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:28 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:28 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:28 opera volumio[21999]: info: Clearing queue after UPNP request Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::ClearQueue Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::stop Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 12:51:28 opera volumio[21999]: verbose: UNSET VOLATILE Apr 20 12:51:28 opera volumio[21999]: info: CorePlayQueue::clearPlayQueue Apr 20 12:51:28 opera volumio[21999]: info: CorePlayQueue::saveQueue Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::volumioPushQueue Apr 20 12:51:28 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:28 opera volumio[21999]: info: Apr 20 12:51:28 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:28 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:28 opera volumio[21999]: error: updateQueue error: null Apr 20 12:51:28 opera volumio[21999]: info: ------------------------------ 2ms Apr 20 12:51:28 opera volumio[21999]: info: Starting UPNP Playback Apr 20 12:51:28 opera volumio[21999]: info: Preparing playback through UPNP Apr 20 12:51:28 opera volumio[21999]: info: CoreCommandRouter::volumioGetState Apr 20 12:51:28 opera volumio[21999]: info: CorePlayQueue::getTrack 0 Apr 20 12:51:28 opera volumio[21999]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:29 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 3ms Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:29 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:29 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:29 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:29 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:29 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:29 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:29 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:29 opera volumio[21999]: info: Apr 20 12:51:29 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:29 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:29 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:29 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:29 opera volumio[21999]: info: sendMpdCommand status took 3 milliseconds Apr 20 12:51:29 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:29 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:29 opera volumio[21999]: info: sendMpdCommand status took 2 milliseconds Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 3ms Apr 20 12:51:29 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:51:29 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:29 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:29 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:29 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:29 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:51:29 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Europa","artist":"Francis Goya","album":"Guitar Forever","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800002jDRhF0ZCk4w.mp3?guid=000000001465bbe0000001784427ee14&vkey=E02CEACE8B9205D6359D6D664C52F2484E79F05B3E3E6706215B88660D874051C58A6A9F3CFD72BA568760FBC79530305B0FA6F75EDDA13F&uin=1959889&src=M800001kZesY4P3YmV.mp3&fromtag=111093","trackType":""} Apr 20 12:51:29 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus stop Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 15ms Apr 20 12:51:29 opera volumio[21999]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 20 12:51:29 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:29 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:29 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:51:29 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Europa","artist":"Francis Goya","album":"Guitar Forever","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800002jDRhF0ZCk4w.mp3?guid=000000001465bbe0000001784427ee14&vkey=E02CEACE8B9205D6359D6D664C52F2484E79F05B3E3E6706215B88660D874051C58A6A9F3CFD72BA568760FBC79530305B0FA6F75EDDA13F&uin=1959889&src=M800001kZesY4P3YmV.mp3&fromtag=111093","trackType":""} Apr 20 12:51:29 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:51:29 opera volumio[21999]: info: Received an update from plugin. extracting info from payload Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:29 opera volumio[21999]: info: ------------------------------ 32ms Apr 20 12:51:29 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:29 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:29 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:29 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:29 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:29 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:29 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:29 opera volumio[21999]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%84%E5%87%AF%E8%8A%B9/Moody/2f45f780-c27a-4311-b72a-10448e3aa1c8.png' Apr 20 12:51:35 opera volumio[21999]: info: Apr 20 12:51:35 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:35 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:35 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:35 opera volumio[21999]: info: sendMpdCommand status took 2 milliseconds Apr 20 12:51:35 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:35 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:35 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:51:35 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:35 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:35 opera volumio[21999]: info: CorePlayQueue::getTrack 0 Apr 20 12:51:35 opera volumio[21999]: 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":"Europa","artist":"Francis Goya","album":"Guitar Forever","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800002jDRhF0ZCk4w.mp3?guid=000000001465bbe0000001784427ee14&vkey=E02CEACE8B9205D6359D6D664C52F2484E79F05B3E3E6706215B88660D874051C58A6A9F3CFD72BA568760FBC79530305B0FA6F75EDDA13F&uin=1959889&src=M800001kZesY4P3YmV.mp3&fromtag=111093","trackType":""} Apr 20 12:51:35 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::syncState stateService stop Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:51:35 opera volumio[21999]: info: ------------------------------ 16ms Apr 20 12:51:35 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:35 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:35 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:35 opera volumio[21999]: info: Clearing queue after UPNP request Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::ClearQueue Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::stop Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 12:51:35 opera volumio[21999]: verbose: UNSET VOLATILE Apr 20 12:51:35 opera volumio[21999]: info: CorePlayQueue::clearPlayQueue Apr 20 12:51:35 opera volumio[21999]: info: CorePlayQueue::saveQueue Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::volumioPushQueue Apr 20 12:51:35 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:35 opera volumio[21999]: info: Apr 20 12:51:35 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:35 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:35 opera volumio[21999]: error: updateQueue error: null Apr 20 12:51:35 opera volumio[21999]: info: ------------------------------ 2ms Apr 20 12:51:35 opera volumio[21999]: info: Starting UPNP Playback Apr 20 12:51:35 opera volumio[21999]: info: Preparing playback through UPNP Apr 20 12:51:35 opera volumio[21999]: info: CoreCommandRouter::volumioGetState Apr 20 12:51:35 opera volumio[21999]: info: CorePlayQueue::getTrack 0 Apr 20 12:51:35 opera volumio[21999]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:36 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 0ms Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:36 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:36 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:36 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:36 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:36 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 2ms Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 2ms Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:36 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:36 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:36 opera volumio[21999]: info: sendMpdCommand status took 1 milliseconds Apr 20 12:51:36 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:36 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:36 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:36 opera volumio[21999]: info: Apr 20 12:51:36 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:36 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:36 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:36 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:51:36 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:36 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:36 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:51:36 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"无情的雨 无情的你","artist":"齐秦","album":"无情的雨无情的你","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800001vNOvA38UmUo.mp3?guid=000000001465bbe0000001784427ee14&vkey=E706D9B2998D75844DB14EC729D5EA53F29E07B6F8BC2847743CCF62C7CB06AD3D29376F60B5FAD555A0E0F6DA59F207448A7F4F4ABC0B6A&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:51:36 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus stop Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 10ms Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 8ms Apr 20 12:51:36 opera volumio[21999]: info: sendMpdCommand status took 7 milliseconds Apr 20 12:51:36 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:36 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:36 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:36 opera volumio[21999]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 20 12:51:36 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:36 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:36 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:51:36 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"无情的雨 无情的你","artist":"齐秦","album":"无情的雨无情的你","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800001vNOvA38UmUo.mp3?guid=000000001465bbe0000001784427ee14&vkey=E706D9B2998D75844DB14EC729D5EA53F29E07B6F8BC2847743CCF62C7CB06AD3D29376F60B5FAD555A0E0F6DA59F207448A7F4F4ABC0B6A&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:51:36 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:51:36 opera volumio[21999]: info: Received an update from plugin. extracting info from payload Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:36 opera volumio[21999]: info: ------------------------------ 24ms Apr 20 12:51:36 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:36 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:36 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:36 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:36 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:36 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:39 opera volumio[21999]: info: Apr 20 12:51:39 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:39 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:39 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:39 opera volumio[21999]: info: sendMpdCommand status took 0 milliseconds Apr 20 12:51:39 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:39 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:39 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:51:39 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:39 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:39 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:39 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:39 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:39 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:39 opera volumio[21999]: info: CorePlayQueue::getTrack 0 Apr 20 12:51:39 opera volumio[21999]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"无情的雨 无情的你","artist":"齐秦","album":"无情的雨无情的你","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800001vNOvA38UmUo.mp3?guid=000000001465bbe0000001784427ee14&vkey=E706D9B2998D75844DB14EC729D5EA53F29E07B6F8BC2847743CCF62C7CB06AD3D29376F60B5FAD555A0E0F6DA59F207448A7F4F4ABC0B6A&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:51:39 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:39 opera volumio[21999]: info: CoreStateMachine::syncState stateService stop Apr 20 12:51:39 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:51:39 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:39 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:39 opera volumio[21999]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:51:39 opera volumio[21999]: info: ------------------------------ 25ms Apr 20 12:51:39 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:39 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:39 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:39 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:39 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:39 opera volumio[21999]: info: Clearing queue after UPNP request Apr 20 12:51:40 opera volumio[21999]: info: CoreStateMachine::ClearQueue Apr 20 12:51:40 opera volumio[21999]: info: CoreStateMachine::stop Apr 20 12:51:40 opera volumio[21999]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 12:51:40 opera volumio[21999]: verbose: UNSET VOLATILE Apr 20 12:51:40 opera volumio[21999]: info: CorePlayQueue::clearPlayQueue Apr 20 12:51:40 opera volumio[21999]: info: CorePlayQueue::saveQueue Apr 20 12:51:40 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:40 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:40 opera volumio[21999]: info: CoreCommandRouter::volumioPushQueue Apr 20 12:51:40 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:40 opera volumio[21999]: info: Apr 20 12:51:40 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:40 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:40 opera volumio[21999]: error: updateQueue error: null Apr 20 12:51:40 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:40 opera volumio[21999]: info: Starting UPNP Playback Apr 20 12:51:40 opera volumio[21999]: info: Preparing playback through UPNP Apr 20 12:51:40 opera volumio[21999]: info: CoreCommandRouter::volumioGetState Apr 20 12:51:40 opera volumio[21999]: info: CorePlayQueue::getTrack 0 Apr 20 12:51:40 opera volumio[21999]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 12:51:40 opera volumio[21999]: info: Apr 20 12:51:40 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:40 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:40 opera volumio[21999]: info: Apr 20 12:51:40 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:40 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:40 opera volumio[21999]: info: ------------------------------ 2ms Apr 20 12:51:40 opera volumio[21999]: info: ------------------------------ 2ms Apr 20 12:51:40 opera volumio[21999]: info: Apr 20 12:51:40 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:40 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:40 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:40 opera volumio[21999]: info: Apr 20 12:51:40 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:40 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:40 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:40 opera volumio[21999]: info: Apr 20 12:51:40 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:40 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:40 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:40 opera volumio[21999]: info: Apr 20 12:51:40 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:40 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:40 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:51:41 opera volumio[21999]: info: Apr 20 12:51:41 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:41 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:41 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:41 opera volumio[21999]: info: Apr 20 12:51:41 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:51:41 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:51:41 opera volumio[21999]: info: Apr 20 12:51:41 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:51:41 opera volumio[21999]: info: sendMpdCommand status took 2 milliseconds Apr 20 12:51:41 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:51:41 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:51:41 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:41 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:41 opera volumio[21999]: info: ------------------------------ 9ms Apr 20 12:51:41 opera volumio[21999]: info: sendMpdCommand status took 4 milliseconds Apr 20 12:51:41 opera volumio[21999]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 20 12:51:41 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:51:41 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:51:41 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:41 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:41 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:51:41 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"心酸的情歌","artist":"巫启贤","album":"心酸的情歌 (广东大碟)","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800003PMKhL3oFlJm.mp3?guid=000000001465bbe0000001784427ee14&vkey=B8BFDAB8197863E2C9F80C551B65FBE07734E009B4726248C67BCD3DF8BAF758C77CE105133F9CA12F082AD3C4C090B05A4ED80326C504F8&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:51:41 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus stop Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:41 opera volumio[21999]: info: ------------------------------ 31ms Apr 20 12:51:41 opera volumio[21999]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 20 12:51:41 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:51:41 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:51:41 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:51:41 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"心酸的情歌","artist":"巫启贤","album":"心酸的情歌 (广东大碟)","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800003PMKhL3oFlJm.mp3?guid=000000001465bbe0000001784427ee14&vkey=B8BFDAB8197863E2C9F80C551B65FBE07734E009B4726248C67BCD3DF8BAF758C77CE105133F9CA12F082AD3C4C090B05A4ED80326C504F8&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:51:41 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:51:41 opera volumio[21999]: info: Received an update from plugin. extracting info from payload Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:51:41 opera volumio[21999]: info: ------------------------------ 48ms Apr 20 12:51:41 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:41 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:41 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:41 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:41 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:51:41 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:51:41 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:51:41 opera volumio[21999]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BD%90%E7%A7%A6/%E6%97%A0%E6%83%85%E7%9A%84%E9%9B%A8%E6%97%A0%E6%83%85%E7%9A%84%E4%BD%A0/f3b133a6-de56-48b8-8c4b-9a9210db08ea.jpg' Apr 20 12:52:06 opera volumio[21999]: info: Apr 20 12:52:06 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:52:06 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:52:06 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:52:06 opera volumio[21999]: info: sendMpdCommand status took 1 milliseconds Apr 20 12:52:06 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:52:06 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:52:06 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:52:06 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:52:06 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:52:06 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:52:06 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:52:06 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:52:06 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:52:06 opera volumio[21999]: info: CorePlayQueue::getTrack 0 Apr 20 12:52:06 opera volumio[21999]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"心酸的情歌","artist":"巫启贤","album":"心酸的情歌 (广东大碟)","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M800003PMKhL3oFlJm.mp3?guid=000000001465bbe0000001784427ee14&vkey=B8BFDAB8197863E2C9F80C551B65FBE07734E009B4726248C67BCD3DF8BAF758C77CE105133F9CA12F082AD3C4C090B05A4ED80326C504F8&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:52:06 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:52:06 opera volumio[21999]: info: CoreStateMachine::syncState stateService stop Apr 20 12:52:06 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:52:06 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:52:06 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:52:06 opera volumio[21999]: info: CoreStateMachine::stPlaybackTimer Apr 20 12:52:06 opera volumio[21999]: info: ------------------------------ 13ms Apr 20 12:52:06 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:52:06 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:52:06 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:52:06 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:52:06 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:52:06 opera volumio[21999]: info: Clearing queue after UPNP request Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::ClearQueue Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::stop Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 12:52:07 opera volumio[21999]: verbose: UNSET VOLATILE Apr 20 12:52:07 opera volumio[21999]: info: CorePlayQueue::clearPlayQueue Apr 20 12:52:07 opera volumio[21999]: info: CorePlayQueue::saveQueue Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::volumioPushQueue Apr 20 12:52:07 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:52:07 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:52:07 opera volumio[21999]: error: updateQueue error: null Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 2ms Apr 20 12:52:07 opera volumio[21999]: info: Starting UPNP Playback Apr 20 12:52:07 opera volumio[21999]: info: Preparing playback through UPNP Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::volumioGetState Apr 20 12:52:07 opera volumio[21999]: info: CorePlayQueue::getTrack 0 Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:52:07 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:52:07 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 0ms Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:52:07 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:52:07 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 1ms Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:52:07 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 0ms Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:52:07 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 0ms Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:52:07 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:52:07 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces system playlist update Apr 20 12:52:07 opera volumio[21999]: info: Ignoring MPD Status Update Apr 20 12:52:07 opera volumio[21999]: info: Apr 20 12:52:07 opera volumio[21999]: ---------------------------- MPD announces state update: player Apr 20 12:52:07 opera volumio[21999]: info: ControllerMpd::getState Apr 20 12:52:07 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:52:07 opera volumio[21999]: info: sendMpdCommand status took 6 milliseconds Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 6ms Apr 20 12:52:07 opera volumio[21999]: info: sendMpdCommand status took 1 milliseconds Apr 20 12:52:07 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:52:07 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:52:07 opera volumio[21999]: verbose: ControllerMpd::parseState Apr 20 12:52:07 opera volumio[21999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:52:07 opera volumio[21999]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 20 12:52:07 opera volumio[21999]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 12:52:07 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:52:07 opera volumio[21999]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:52:07 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:52:07 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:52:07 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"哪里的天空不下雨","artist":"梁雁翎","album":"想你","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M8000028fRxN3HIpYx.mp3?guid=000000001465bbe0000001784427ee14&vkey=5B330C945B023C47C5CAB8F88FFFF41FF72C6BF65B71322D1FE8276F205D91922C77A23CD5516950ED7B3AF3715940B5E744DEFF013BE35F&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:52:07 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus stop Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:52:07 opera volumio[21999]: info: ControllerMpd::pushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::servicePushState Apr 20 12:52:07 opera volumio[21999]: verbose: In UPNP mode Apr 20 12:52:07 opera volumio[21999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"哪里的天空不下雨","artist":"梁雁翎","album":"想你","uri":"http://113.215.236.168/amobile.music.tc.qq.com/M8000028fRxN3HIpYx.mp3?guid=000000001465bbe0000001784427ee14&vkey=5B330C945B023C47C5CAB8F88FFFF41FF72C6BF65B71322D1FE8276F205D91922C77A23CD5516950ED7B3AF3715940B5E744DEFF013BE35F&uin=1959889&fromtag=111093","trackType":""} Apr 20 12:52:07 opera volumio[21999]: verbose: CURRENT POSITION 0 Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::syncState stateService play Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:52:07 opera volumio[21999]: info: Received an update from plugin. extracting info from payload Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::pushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::volumioPushState Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 42ms Apr 20 12:52:07 opera volumio[21999]: info: ------------------------------ 37ms Apr 20 12:52:07 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:52:07 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:52:07 opera volumio[21999]: info: Updating RAAT Signal Path Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:52:07 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:52:07 opera volumio[21999]: info: CoreCommandRouter::volumioGetQueue Apr 20 12:52:07 opera volumio[21999]: info: CoreStateMachine::getQueue Apr 20 12:52:07 opera volumio[21999]: info: CorePlayQueue::getQueue Apr 20 12:52:08 opera volumio[21999]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%A2%81%E9%9B%81%E7%BF%8E/%E6%83%B3%E4%BD%A0/e65810f5-e274-49ff-abf1-eb658769f7d0.jpg' Apr 20 12:52:18 opera volumio[21999]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 12:52:18 opera volumio[21999]: { Error: connect ETIMEDOUT 31.13.112.4:443 Apr 20 12:52:18 opera volumio[21999]: at Object._errnoException (util.js:1022:11) Apr 20 12:52:18 opera volumio[21999]: at _exceptionWithHostPort (util.js:1044:20) Apr 20 12:52:18 opera volumio[21999]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 20 12:52:18 opera volumio[21999]: code: 'ETIMEDOUT', Apr 20 12:52:18 opera volumio[21999]: errno: 'ETIMEDOUT', Apr 20 12:52:18 opera volumio[21999]: syscall: 'connect', Apr 20 12:52:18 opera volumio[21999]: address: '31.13.112.4', Apr 20 12:52:18 opera volumio[21999]: port: 443 } Apr 20 12:52:18 opera volumio[21999]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 12:52:19 opera sudo[25128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-20 12:51 Apr 20 12:52:19 opera sudo[25128]: 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"