-- Logs begin at Tue 2026-06-02 05:51:04 UTC, end at Tue 2026-06-02 07:51:32 UTC. -- Jun 02 07:50:00 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Jun 02 07:50:00 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 02 07:50:01 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Jun 02 07:50:01 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 02 07:50:02 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Jun 02 07:50:02 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 02 07:50:03 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Jun 02 07:50:03 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 02 07:50:04 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Jun 02 07:50:04 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 02 07:50:05 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Jun 02 07:50:05 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 02 07:50:06 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Jun 02 07:50:06 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::ClearQueue Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::stop Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:06 opera volumio[7906]: verbose: UNSET VOLATILE Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::clearPlayQueue Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::saveQueue Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::volumioPushQueue Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::addQueueItems Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::addQueueItems Jun 02 07:50:06 opera volumio[7906]: info: Adding Item to queue: music-library/NAS/福叔/妙音唱片 绝对发烧23 Jun 02 07:50:06 opera volumio[7906]: info: Exploding uri music-library/NAS/福叔/妙音唱片 绝对发烧23 in service mpd Jun 02 07:50:06 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F01.%20%E4%B8%8D%E5%BA%94%E5%86%8D%E7%8A%B9%E8%B1%AB.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/01. 不应再犹豫.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F02.%20%E8%90%BD%E8%8A%B1%E6%B3%AA%E5%BD%B1.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/02. 落花泪影.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F03.%20Scarborough%20Fair%E6%96%AF%E5%8D%A1%E7%BD%97%E5%B8%83%E5%B8%82%E9%9B%86.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/03. Scarborough Fair斯卡罗布市集.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F04.%20%E4%BA%B2%E5%AF%86%E7%88%B1%E4%BA%BA.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/04. 亲密爱人.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F05.%20%E8%91%AC%E5%BF%83.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/05. 葬心.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F06.%20%E7%87%95%E5%AD%90.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/06. 燕子.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F07.%20%E6%83%B3%E8%B5%B7%E8%80%81%E5%A6%88%E5%A6%88.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/07. 想起老妈妈.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F08.%20%E7%94%9C%E8%A8%80%E8%9C%9C%E8%AF%AD.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/08. 甜言蜜语.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F09.%20%E7%9F%A5%E9%81%93%E4%B8%8D%E7%9F%A5%E9%81%93.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/09. 知道不知道.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F10.%20%E8%AF%B7%E4%B8%8D%E5%BF%85%E5%86%8D%E7%AD%89.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/10. 请不必再等.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F11.%20Love%20me%20like%20you%20do%20%E5%83%8F%E4%BD%A0%E4%B8%80%E6%A0%B7%E7%88%B1%E6%88%91.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/11. Love me like you do 像你一样爱我.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F12.%20%E9%B8%BF%E9%9B%81.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/12. 鸿雁.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F13.%20%E6%BC%AB%E6%AD%A5%E4%BA%BA%E7%94%9F%E8%B7%AF.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/13. 漫步人生路.wav Jun 02 07:50:06 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=%3F%3F//extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A723%2F14.%20%E6%9C%80%E7%9C%9F%E7%9A%84%E6%A2%A6.wav&metadata=false Jun 02 07:50:06 opera volumio[7906]: info: URI /mnt/NAS/福叔/妙音唱片 绝对发烧23/14. 最真的梦.wav Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::saveQueue Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::volumioPushQueue Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::updateTrackBlock Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::getTrackBlock Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::volumioPlay Jun 02 07:50:06 opera volumio[7906]: verbose: UNSET VOLATILE Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::play index 0 Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::stop Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:06 opera volumio[7906]: verbose: UNSET VOLATILE Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::play index undefined Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::startPlaybackTimer Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::clearAddPlayTracks NAS/福叔/妙音唱片 绝对发烧23/01. 不应再犹豫.wav Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 07:50:06 opera volumio[7906]: info: Jun 02 07:50:06 opera volumio[7906]: ---------------------------- MPD announces state update: player Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand stop took 3 milliseconds Jun 02 07:50:06 opera volumio[7906]: info: ControllerMpd::getState Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand status Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 07:50:06 opera volumio[7906]: info: Jun 02 07:50:06 opera volumio[7906]: ---------------------------- MPD announces system playlist update Jun 02 07:50:06 opera volumio[7906]: info: Ignoring MPD Status Update Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand status took 4 milliseconds Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand clear took 5 milliseconds Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::parseState Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand add "NAS/福叔/妙音唱片 绝对发烧23/01. 不应再犹豫.wav" Jun 02 07:50:06 opera volumio[7906]: error: updateQueue error: null Jun 02 07:50:06 opera volumio[7906]: info: Jun 02 07:50:06 opera volumio[7906]: ---------------------------- MPD announces system playlist update Jun 02 07:50:06 opera volumio[7906]: info: Ignoring MPD Status Update Jun 02 07:50:06 opera volumio[7906]: info: ------------------------------ 4ms Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand add "NAS/福叔/妙音唱片 绝对发烧23/01. 不应再犹豫.wav" took 2 milliseconds Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::parseTrackInfo Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand play Jun 02 07:50:06 opera volumio[7906]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 07:50:06 opera volumio[7906]: info: ------------------------------ 11ms Jun 02 07:50:06 opera volumio[7906]: info: ------------------------------ 6ms Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand play took 5 milliseconds Jun 02 07:50:06 opera volumio[7906]: info: Jun 02 07:50:06 opera volumio[7906]: ---------------------------- MPD announces state update: player Jun 02 07:50:06 opera volumio[7906]: info: ControllerMpd::getState Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand status Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand status took 146 milliseconds Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::parseState Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 07:50:06 opera volumio[7906]: info: Jun 02 07:50:06 opera volumio[7906]: ---------------------------- MPD announces state update: player Jun 02 07:50:06 opera volumio[7906]: info: ControllerMpd::getState Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand status Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::parseTrackInfo Jun 02 07:50:06 opera volumio[7906]: info: ControllerMpd::pushState Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:06 opera volumio[7906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":null,"uri":"NAS/福叔/妙音唱片 绝对发烧23/01. 不应再犹豫.wav","trackType":"wav"} Jun 02 07:50:06 opera volumio[7906]: verbose: CURRENT POSITION 0 Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::syncState stateService play Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::syncState currentStatus stop Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:06 opera volumio[7906]: info: ------------------------------ 160ms Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand status took 9 milliseconds Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::parseState Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 07:50:06 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:06 opera volumio[7906]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 02 07:50:06 opera volumio[7906]: verbose: ControllerMpd::parseTrackInfo Jun 02 07:50:06 opera volumio[7906]: info: ControllerMpd::pushState Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:06 opera volumio[7906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????","artist":"??","album":null,"uri":"NAS/福叔/妙音唱片 绝对发烧23/01. 不应再犹豫.wav","trackType":"wav"} Jun 02 07:50:06 opera volumio[7906]: verbose: CURRENT POSITION 0 Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::syncState stateService play Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::syncState currentStatus play Jun 02 07:50:06 opera volumio[7906]: info: Received an update from plugin. extracting info from payload Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:06 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:06 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:06 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:06 opera volumio[7906]: info: ------------------------------ 38ms Jun 02 07:50:06 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:06 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:07 opera volumio[7906]: ------------------------------------ BT MESSAGE: BT STATUS: pending Jun 02 07:50:07 opera volumio[7906]: ------------------------------------ BT MESSAGE: BT STATUS: active Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: Playing: true Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: VOLATILE: undefined Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: STATE:undefined Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::volumioStop Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::stop Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:07 opera volumio[7906]: verbose: UNSET VOLATILE Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::stPlaybackTimer Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::updateTrackBlock Jun 02 07:50:07 opera volumio[7906]: info: CorePlayQueue::getTrackBlock Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:07 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::serviceStop Jun 02 07:50:07 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::serviceStop Jun 02 07:50:07 opera volumio[7906]: info: ControllerMpd::stop Jun 02 07:50:07 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 07:50:07 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:07 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Jun 02 07:50:07 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 4 Jun 02 07:50:07 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Jun 02 07:50:07 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Jun 02 07:50:07 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Jun 02 07:50:07 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Jun 02 07:50:07 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x04 Jun 02 07:50:07 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Jun 02 07:50:07 opera kernel: rtk_btcoex: rtp: v 2, cc 0, pt 96 Jun 02 07:50:07 opera kernel: rtk_btcoex: syncword: 9c Jun 02 07:50:07 opera kernel: rtk_btcoex: freq 44.1kHz Jun 02 07:50:07 opera kernel: rtk_btcoex: blocks 16 Jun 02 07:50:07 opera kernel: rtk_btcoex: channel mode JOINT_STEREO Jun 02 07:50:07 opera kernel: rtk_btcoex: allocation method LOUDNESS Jun 02 07:50:07 opera kernel: rtk_btcoex: subbands 8 Jun 02 07:50:07 opera kernel: rtk_btcoex: bitpool 53 Jun 02 07:50:07 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc51 Jun 02 07:50:07 opera volumio[7906]: ------------------------------------ BT MESSAGE: BT STATUS: playing Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: Playing: true Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: VOLATILE: undefined Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: STATE:undefined Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::volumioStop Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::stop Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:07 opera volumio[7906]: verbose: UNSET VOLATILE Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: BLUETOOTH: Starting Playback Routine Jun 02 07:50:07 opera volumio[7906]: info: Enabling Bluetooth Audio Output Jun 02 07:50:07 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Jun 02 07:50:07 opera volumio[7906]: info: Jun 02 07:50:07 opera volumio[7906]: ---------------------------- MPD announces state update: player Jun 02 07:50:07 opera volumio[7906]: info: sendMpdCommand stop took 102 milliseconds Jun 02 07:50:07 opera volumio[7906]: info: ControllerMpd::getState Jun 02 07:50:07 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand status Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: BLUETOOTH: Starting Playback Routine Jun 02 07:50:07 opera volumio[7906]: info: Enabling Bluetooth Audio Output Jun 02 07:50:07 opera volumio[7906]: info: sendMpdCommand status took 33 milliseconds Jun 02 07:50:07 opera volumio[7906]: verbose: ControllerMpd::parseState Jun 02 07:50:07 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 07:50:07 opera volumio[7906]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 02 07:50:07 opera volumio[7906]: verbose: ControllerMpd::parseTrackInfo Jun 02 07:50:07 opera volumio[7906]: info: ControllerMpd::pushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:07 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:07 opera volumio[7906]: 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":null,"uri":"NAS/福叔/妙音唱片 绝对发烧23/01. 不应再犹豫.wav","trackType":"wav"} Jun 02 07:50:07 opera volumio[7906]: verbose: CURRENT POSITION 0 Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::syncState stateService stop Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::syncState currentStatus stop Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:07 opera volumio[7906]: info: No code Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:07 opera volumio[7906]: info: ------------------------------ 51ms Jun 02 07:50:07 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:07 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:07 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:07 opera pulseaudio[1870]: Failed to load module "module-alsa-sink" (argument: "device=plughw:5,0"): initialization failed. Jun 02 07:50:07 opera volumio[7906]: error: Cannot load module of audio hardware: Error: Command failed: /usr/bin/pactl load-module module-alsa-sink device=plughw:5,0 Jun 02 07:50:07 opera volumio[7906]: No protocol specified Jun 02 07:50:07 opera volumio[7906]: xcb_connection_has_error() returned true Jun 02 07:50:07 opera volumio[7906]: Failure: Module initialization failed Jun 02 07:50:07 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 20 Jun 02 07:50:07 opera volumio[7906]: No protocol specified Jun 02 07:50:07 opera volumio[7906]: xcb_connection_has_error() returned true Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: SINK LOADED: 11 Jun 02 07:50:07 opera volumio[7906]: info: Alsa Sink Already Loaded Jun 02 07:50:07 opera volumio[7906]: info: Bluetooth Audio successfully Enabled Jun 02 07:50:07 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:07 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:07 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:07 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:07 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:08 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Jun 02 07:50:08 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70 Jun 02 07:50:08 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:08 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:08 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:08 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:08 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:08 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:08 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:08 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:08 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:08 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:09 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:09 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 3 Jun 02 07:50:09 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 67 Jun 02 07:50:09 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:09 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:09 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:09 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:09 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:09 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:09 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:09 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:09 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:09 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:09 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:10 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Jun 02 07:50:10 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70 Jun 02 07:50:10 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:10 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:10 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:10 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:10 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:10 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:10 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:10 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:10 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:10 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:10 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:11 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 5 Jun 02 07:50:11 opera kernel: rtk_btcoex: timeout_handler: pan idle->busy! Jun 02 07:50:11 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Jun 02 07:50:11 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = c Jun 02 07:50:11 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Jun 02 07:50:11 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Jun 02 07:50:11 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Jun 02 07:50:11 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Jun 02 07:50:11 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x0c Jun 02 07:50:11 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Jun 02 07:50:11 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70 Jun 02 07:50:11 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:11 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:11 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:11 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:11 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:11 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:11 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:11 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:11 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:11 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:11 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:12 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 3 Jun 02 07:50:12 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan busy->idle! Jun 02 07:50:12 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Jun 02 07:50:12 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = 4 Jun 02 07:50:12 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Jun 02 07:50:12 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Jun 02 07:50:12 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Jun 02 07:50:12 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Jun 02 07:50:12 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x04 Jun 02 07:50:12 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Jun 02 07:50:12 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69 Jun 02 07:50:12 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:12 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:12 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:12 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:12 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:12 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:13 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:13 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:13 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Jun 02 07:50:13 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 67 Jun 02 07:50:13 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:13 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:13 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:13 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:13 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:14 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:14 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Jun 02 07:50:14 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 68 Jun 02 07:50:14 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:14 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:14 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:14 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:14 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:14 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:15 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:15 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:15 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Jun 02 07:50:15 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 71 Jun 02 07:50:15 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:15 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:15 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:15 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:15 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:15 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:16 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Jun 02 07:50:16 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 69 Jun 02 07:50:16 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:16 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:16 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:16 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:16 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:16 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:17 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:17 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:17 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:17 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:17 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:17 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Jun 02 07:50:17 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 66 Jun 02 07:50:17 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:17 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:17 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:17 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:17 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:17 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:18 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:18 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:18 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 4 Jun 02 07:50:18 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 70 Jun 02 07:50:18 opera dhcpd[1397]: DHCPDISCOVER from 48:e7:da:4e:fa:c3 (opera) via wlan0 Jun 02 07:50:18 opera volumio[7906]: BT PLUGIN MESSAGE: Duration is 403000 Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:18 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:18 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:18 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:18 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:18 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:19 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 5 Jun 02 07:50:19 opera kernel: rtk_btcoex: timeout_handler: pan idle->busy! Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profie_bitmap = c Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_state: btrtl_coex.profile_status = c Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x0c Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x0c Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Jun 02 07:50:19 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 71 Jun 02 07:50:19 opera dhcpd[1397]: DHCPOFFER on 192.168.211.6 to 48:e7:da:4e:fa:c3 (opera) via wlan0 Jun 02 07:50:19 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0001, dcid 0x0043, scid 0x0309 Jun 02 07:50:19 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x0043, scid 0x0309, dir 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: is_add 0, profile_index 2 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x0c Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 2 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: Delete profile: hndl 0x0001, psm 0x0019, dcid 0x0309, scid 0x0043 Jun 02 07:50:19 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: TX l2cap disconn req, hndl 0x0001, dcid 0x060c, scid 0x0044 Jun 02 07:50:19 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x060c, scid 0x0044, dir 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: is_add 0, profile_index 3 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x0c Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: Delete profile: hndl 0x0001, psm 0x001b, dcid 0x060c, scid 0x0044 Jun 02 07:50:19 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: TX l2cap disconn req, hndl 0x0001, dcid 0x0208, scid 0x0040 Jun 02 07:50:19 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x0208, scid 0x0040, dir 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0001, dcid 0x0044, scid 0x060c Jun 02 07:50:19 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x0044, scid 0x060c, dir 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0001, dcid 0x0040, scid 0x0208 Jun 02 07:50:19 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x0040, scid 0x0208, dir 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0001, dcid 0x0041, scid 0x040a Jun 02 07:50:19 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x0041, scid 0x040a, dir 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: is_add 0, profile_index 3 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x04 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0001 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x04 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x04 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Jun 02 07:50:19 opera kernel: rtk_btcoex: Delete profile: hndl 0x0001, psm 0x001f, dcid 0x040a, scid 0x0041 Jun 02 07:50:19 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0001, dcid 0x0045, scid 0x070d Jun 02 07:50:19 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x0045, scid 0x070d, dir 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: is_add 0, profile_index 2 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x00 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 2 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 0 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00 Jun 02 07:50:19 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Jun 02 07:50:19 opera kernel: rtk_btcoex: Delete profile: hndl 0x0001, psm 0x0019, dcid 0x070d, scid 0x0045 Jun 02 07:50:19 opera dbus[694]: [system] Rejected send message, 3 matched rules; type="method_return", sender=":1.20" (uid=1000 pid=1870 comm="/usr/bin/pulseaudio ") interface="(unset)" member="(unset)" error name="(unset)" requested_reply="0" destination=":1.7" (uid=0 pid=870 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jun 02 07:50:19 opera kernel: rtk_btcoex: process disconn complete event. Jun 02 07:50:28 opera sudo[10380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 07:50:28 opera sudo[10380]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 07:50:28 opera sudo[10380]: pam_unix(sudo:session): session closed for user root Jun 02 07:50:28 opera sudo[10384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 07:50:28 opera sudo[10384]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 07:50:28 opera sudo[10384]: pam_unix(sudo:session): session closed for user root Jun 02 07:50:28 opera volumio[7906]: info: CoreCommandRouter::volumioGetState Jun 02 07:50:28 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 07:50:28 opera volumio[7906]: error: Could not retrieve plugin audio_interface multiroom Jun 02 07:50:28 opera volumio[7906]: info: Listing playlists Jun 02 07:50:28 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 02 07:50:28 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 02 07:50:28 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 02 07:50:28 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 07:50:29 opera volumio[7906]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jun 02 07:50:29 opera volumio[7906]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jun 02 07:50:29 opera volumio[7906]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jun 02 07:50:29 opera volumio[7906]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jun 02 07:50:29 opera volumio[7906]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jun 02 07:50:29 opera volumio[7906]: at Promise._failFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:445:13) Jun 02 07:50:29 opera volumio[7906]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 02 07:50:29 opera volumio[7906]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jun 02 07:50:29 opera volumio[7906]: at process._tickCallback (internal/process/next_tick.js:180:9) Jun 02 07:50:34 opera volumio[7906]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 07:50:34 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 07:50:34 opera volumio[7906]: info: CoreCommandRouter::volumioGetQueue Jun 02 07:50:34 opera volumio[7906]: info: CoreStateMachine::getQueue Jun 02 07:50:34 opera volumio[7906]: info: CorePlayQueue::getQueue Jun 02 07:50:36 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 07:50:36 opera volumio[7906]: info: CURURI: music-library Jun 02 07:50:36 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 07:50:36 opera volumio[7906]: info: CURURI: music-library/NAS Jun 02 07:50:37 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 07:50:37 opera volumio[7906]: info: CURURI: music-library/NAS/福叔 Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::ClearQueue Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::stop Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::serviceStop Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::serviceStop Jun 02 07:50:42 opera volumio[7906]: error: Could not retrieve plugin music_service bluetooth Jun 02 07:50:42 opera volumio[7906]: info: Bluetooth STOP Command Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::clearPlayQueue Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::saveQueue Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::volumioPushQueue Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::addQueueItems Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::addQueueItems Jun 02 07:50:42 opera volumio[7906]: info: Adding Item to queue: music-library/NAS/福叔/Alan Tam - SACD Album Two Jun 02 07:50:42 opera volumio[7906]: info: Exploding uri music-library/NAS/福叔/Alan Tam - SACD Album Two in service mpd Jun 02 07:50:42 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F01%20-%20Alan%20Tam%20-%20%E9%9B%A8%E7%B5%B2%E2%80%A7%E6%83%85%E6%84%81.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/01 - Alan Tam - 雨絲‧情愁.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F02%20-%20Alan%20Tam%20-%E6%B0%B4%E4%B8%AD%E8%8A%B1.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/02 - Alan Tam -水中花.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F03%20-%20Alan%20Tam%20-%20%E5%86%8D%E8%A6%8B%E4%BA%A6%E6%98%AF%E6%B7%9A.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/03 - Alan Tam - 再見亦是淚.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F04%20-%20Alan%20Tam%20-%20%E8%AC%9B%E4%B8%8D%E5%87%BA%E5%86%8D%E8%A6%8B.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/04 - Alan Tam - 講不出再見.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F05%20-%20Alan%20Tam%20-%20%E6%9B%BE%E7%B6%93.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/05 - Alan Tam - 曾經.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F06%20-%20Alan%20Tam%20-%20%E8%AA%B0%E5%8F%AF%E6%94%B9%E8%AE%8A.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/06 - Alan Tam - 誰可改變.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F07%20-%20Alan%20Tam%20-%20%E6%83%85%E6%86%91%E8%AA%B0%E4%BE%86%E5%AE%9A%E9%8C%AF%E5%B0%8D.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/07 - Alan Tam - 情憑誰來定錯對.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F08%20-%20Alan%20Tam%20-%20%E5%90%BB%E5%88%A5.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/08 - Alan Tam - 吻別.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F09%20-%20Alan%20Tam%20-%20%E6%9C%8B%E5%8F%8B.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/09 - Alan Tam - 朋友.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F10%20-%20Alan%20Tam%20-%20%E6%98%8E%E5%A4%A9%E4%BD%A0%E6%98%AF%E5%90%A6%E4%BE%9D%E7%84%B6%E6%84%9B%E6%88%91%20(%E8%AD%9A%E8%A9%A0%E9%BA%9F%E9%97%9C%E6%B7%91%E6%80%A1).dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/10 - Alan Tam - 明天你是否依然愛我 (譚詠麟關淑怡).dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F11%20-%20Alan%20Tam%20-%20%E8%AE%8A%E5%A5%8F.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/11 - Alan Tam - 變奏.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F12%20-%20Alan%20Tam%20-%20%E7%B7%A8%E7%B9%94.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/12 - Alan Tam - 編織.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F13%20-%20Alan%20Tam%20-%20%E4%B9%9F%E6%9B%BE%E7%9B%B8%E8%AD%98.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/13 - Alan Tam - 也曾相識.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F14%20-%20Alan%20Tam%20-%20%E7%97%B4%E5%BF%83%E7%9A%84%E5%BB%A2%E5%A2%9F.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/14 - Alan Tam - 痴心的廢墟.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F15%20-%20Alan%20Tam%20-%20%E9%82%84%E6%98%AF%E4%BD%A0%E6%87%82%E5%BE%97%E6%84%9B%E6%88%91.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/15 - Alan Tam - 還是你懂得愛我.dsf Jun 02 07:50:42 opera volumio[7906]: info: ALBUMART /albumart?cacheid=201&web=Alan%20Tam/Alan%20Tam%20SACD%20Album%20Two/extralarge&path=%2Fmnt%2FNAS%2F%E7%A6%8F%E5%8F%94%2FAlan%20Tam%20-%20SACD%20Album%20Two%2F16%20-%20Alan%20Tam%20-%20%E7%84%A1%E8%A8%80%E6%84%9F%E6%BF%80.dsf&metadata=false Jun 02 07:50:42 opera volumio[7906]: info: URI /mnt/NAS/福叔/Alan Tam - SACD Album Two/16 - Alan Tam - 無言感激.dsf Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::saveQueue Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::volumioPushQueue Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::updateTrackBlock Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::getTrackBlock Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::volumioPlay Jun 02 07:50:42 opera volumio[7906]: verbose: UNSET VOLATILE Jun 02 07:50:42 opera volumio[7906]: info: Bluetooth Detach Command Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::play index 0 Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::stop Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:42 opera volumio[7906]: verbose: UNSET VOLATILE Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::stPlaybackTimer Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::updateTrackBlock Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::getTrackBlock Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::serviceStop Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:42 opera volumio[7906]: info: CoreCommandRouter::serviceStop Jun 02 07:50:42 opera volumio[7906]: info: ControllerMpd::stop Jun 02 07:50:42 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 07:50:42 opera volumio[7906]: info: sendMpdCommand stop took 42 milliseconds Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::play index undefined Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:42 opera volumio[7906]: info: CoreStateMachine::startPlaybackTimer Jun 02 07:50:42 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:42 opera volumio[7906]: verbose: ControllerMpd::clearAddPlayTracks NAS/福叔/Alan Tam - SACD Album Two/01 - Alan Tam - 雨絲‧情愁.dsf Jun 02 07:50:42 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 07:50:42 opera volumio[7906]: info: sendMpdCommand stop took 19 milliseconds Jun 02 07:50:42 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 07:50:42 opera volumio[7906]: info: Bluetooth Audio successfully Disabled Jun 02 07:50:42 opera volumio[7906]: info: Bluetooth Successfully Stopped Jun 02 07:50:42 opera volumio[7906]: info: Jun 02 07:50:42 opera volumio[7906]: ---------------------------- MPD announces system playlist update Jun 02 07:50:42 opera volumio[7906]: info: Ignoring MPD Status Update Jun 02 07:50:42 opera volumio[7906]: info: sendMpdCommand clear took 2 milliseconds Jun 02 07:50:42 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand add "NAS/福叔/Alan Tam - SACD Album Two/01 - Alan Tam - 雨絲‧情愁.dsf" Jun 02 07:50:42 opera volumio[7906]: error: updateQueue error: null Jun 02 07:50:42 opera volumio[7906]: info: Jun 02 07:50:42 opera volumio[7906]: ---------------------------- MPD announces system playlist update Jun 02 07:50:42 opera volumio[7906]: info: Ignoring MPD Status Update Jun 02 07:50:42 opera volumio[7906]: info: ------------------------------ 5ms Jun 02 07:50:42 opera volumio[7906]: info: sendMpdCommand add "NAS/福叔/Alan Tam - SACD Album Two/01 - Alan Tam - 雨絲‧情愁.dsf" took 4 milliseconds Jun 02 07:50:42 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand play Jun 02 07:50:42 opera volumio[7906]: info: ------------------------------ 3ms Jun 02 07:50:42 opera volumio[7906]: info: sendMpdCommand play took 2 milliseconds Jun 02 07:50:42 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:42 opera volumio[7906]: info: Bluetooth Audio successfully Disabled Jun 02 07:50:42 opera volumio[7906]: info: Bluetooth Successfully Detached Jun 02 07:50:43 opera volumio[7906]: info: Jun 02 07:50:43 opera volumio[7906]: ---------------------------- MPD announces state update: player Jun 02 07:50:43 opera volumio[7906]: info: ControllerMpd::getState Jun 02 07:50:43 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand status Jun 02 07:50:43 opera volumio[7906]: info: sendMpdCommand status took 370 milliseconds Jun 02 07:50:43 opera volumio[7906]: verbose: ControllerMpd::parseState Jun 02 07:50:43 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 07:50:43 opera volumio[7906]: info: Jun 02 07:50:43 opera volumio[7906]: ---------------------------- MPD announces state update: player Jun 02 07:50:43 opera volumio[7906]: info: ControllerMpd::getState Jun 02 07:50:43 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand status Jun 02 07:50:43 opera volumio[7906]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 02 07:50:43 opera volumio[7906]: verbose: ControllerMpd::parseTrackInfo Jun 02 07:50:43 opera volumio[7906]: info: ControllerMpd::pushState Jun 02 07:50:43 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:43 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:43 opera volumio[7906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"Fall In Love","artist":"Alan Tam","album":"Alan Tam SACD Album Two","uri":"NAS/福叔/Alan Tam - SACD Album Two/01 - Alan Tam - 雨絲‧情愁.dsf","trackType":"dsf"} Jun 02 07:50:43 opera volumio[7906]: verbose: CURRENT POSITION 0 Jun 02 07:50:43 opera volumio[7906]: info: CoreStateMachine::syncState stateService play Jun 02 07:50:43 opera volumio[7906]: info: CoreStateMachine::syncState currentStatus stop Jun 02 07:50:43 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:43 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:43 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:43 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:43 opera volumio[7906]: info: ------------------------------ 379ms Jun 02 07:50:43 opera volumio[7906]: info: sendMpdCommand status took 7 milliseconds Jun 02 07:50:43 opera volumio[7906]: verbose: ControllerMpd::parseState Jun 02 07:50:43 opera volumio[7906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 07:50:43 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:43 opera volumio[7906]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 02 07:50:43 opera volumio[7906]: verbose: ControllerMpd::parseTrackInfo Jun 02 07:50:43 opera volumio[7906]: info: ControllerMpd::pushState Jun 02 07:50:43 opera volumio[7906]: info: CoreCommandRouter::servicePushState Jun 02 07:50:43 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:43 opera volumio[7906]: verbose: STATE SERVICE {"status":"play","position":0,"seek":493,"duration":202,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"Fall In Love","artist":"Alan Tam","album":"Alan Tam SACD Album Two","uri":"NAS/福叔/Alan Tam - SACD Album Two/01 - Alan Tam - 雨絲‧情愁.dsf","trackType":"dsf"} Jun 02 07:50:43 opera volumio[7906]: verbose: CURRENT POSITION 0 Jun 02 07:50:43 opera volumio[7906]: info: CoreStateMachine::syncState stateService play Jun 02 07:50:43 opera volumio[7906]: info: CoreStateMachine::syncState currentStatus play Jun 02 07:50:43 opera volumio[7906]: info: Received an update from plugin. extracting info from payload Jun 02 07:50:43 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:43 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:43 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:43 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:43 opera volumio[7906]: info: CoreStateMachine::pushState Jun 02 07:50:43 opera volumio[7906]: info: CorePlayQueue::getTrack 0 Jun 02 07:50:43 opera volumio[7906]: info: CoreCommandRouter::volumioPushState Jun 02 07:50:43 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 07:50:43 opera volumio[7906]: info: ------------------------------ 31ms Jun 02 07:50:43 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:43 opera volumio[7906]: info: Updating RAAT Signal Path Jun 02 07:50:58 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 07:50:58 opera volumio[7906]: info: CURURI: music-library/NAS/福叔/dsd Jun 02 07:51:21 opera dhcpd[1397]: DHCPDISCOVER from 48:e7:da:4e:fa:c3 (opera) via wlan0 Jun 02 07:51:22 opera dhcpd[1397]: DHCPOFFER on 192.168.211.6 to 48:e7:da:4e:fa:c3 (opera) via wlan0 Jun 02 07:51:27 opera volumio[7906]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 07:51:27 opera volumio[7906]: info: CURURI: music-library/NAS/福叔/合集13：中国歌曲 Jun 02 07:51:31 opera volumio[7906]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 07:51:31 opera volumio[7906]: { Error: connect ETIMEDOUT 31.13.80.37:443 Jun 02 07:51:31 opera volumio[7906]: at Object._errnoException (util.js:1022:11) Jun 02 07:51:31 opera volumio[7906]: at _exceptionWithHostPort (util.js:1044:20) Jun 02 07:51:31 opera volumio[7906]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 02 07:51:31 opera volumio[7906]: code: 'ETIMEDOUT', Jun 02 07:51:31 opera volumio[7906]: errno: 'ETIMEDOUT', Jun 02 07:51:31 opera volumio[7906]: syscall: 'connect', Jun 02 07:51:31 opera volumio[7906]: address: '31.13.80.37', Jun 02 07:51:31 opera volumio[7906]: port: 443 } Jun 02 07:51:31 opera volumio[7906]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 07:51:32 opera sudo[10570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 07:50 Jun 02 07:51:32 opera sudo[10570]: 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"