-- Logs begin at Fri 2013-01-18 08:50:23 UTC, end at Mon 2025-06-30 06:45:51 UTC. -- Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioAddQueueItems Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::addQueueItems Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::addQueueItems Jun 30 06:44:08 opera volumio[1021]: info: Adding Item to queue: music-library/USB/M2/MUSIC/宋小睿 - 点歌的人.mp3 Jun 30 06:44:08 opera volumio[1021]: info: Exploding uri music-library/USB/M2/MUSIC/宋小睿 - 点歌的人.mp3 in service mpd Jun 30 06:44:08 opera volumio[1021]: info: ALBUMART /albumart?cacheid=915&web=%E5%AE%8B%E5%B0%8F%E7%9D%BF//extralarge&path=%2Fmnt%2FUSB%2FM2%2FMUSIC%2F%E5%AE%8B%E5%B0%8F%E7%9D%BF%20-%20%E7%82%B9%E6%AD%8C%E7%9A%84%E4%BA%BA.mp3&metadata=false Jun 30 06:44:08 opera volumio[1021]: info: URI /mnt/USB/M2/MUSIC/宋小睿 - 点歌的人.mp3 Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::saveQueue Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPushQueue Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::updateTrackBlock Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrackBlock Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPlay Jun 30 06:44:08 opera volumio[1021]: verbose: UNSET VOLATILE Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::play index 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::stop Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 06:44:08 opera volumio[1021]: verbose: UNSET VOLATILE Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::stPlaybackTimer Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::updateTrackBlock Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrackBlock Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 53 Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::serviceStop Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 53 Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::serviceStop Jun 30 06:44:08 opera volumio[1021]: info: ControllerMpd::stop Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Jun 30 06:44:08 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:44:08 opera volumio[1021]: info: Jun 30 06:44:08 opera volumio[1021]: ---------------------------- MPD announces state update: player Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand stop took 22 milliseconds Jun 30 06:44:08 opera volumio[1021]: info: ControllerMpd::getState Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::play index undefined Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::startPlaybackTimer Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::clearAddPlayTracks USB/M2/MUSIC/宋小睿 - 点歌的人.mp3 Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand status took 4 milliseconds Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand stop took 4 milliseconds Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::parseState Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Jun 30 06:44:08 opera volumio[1021]: info: Jun 30 06:44:08 opera volumio[1021]: ---------------------------- MPD announces system playlist update Jun 30 06:44:08 opera volumio[1021]: info: Ignoring MPD Status Update Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand clear took 4 milliseconds Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand add "USB/M2/MUSIC/宋小睿 - 点歌的人.mp3" Jun 30 06:44:08 opera volumio[1021]: info: ControllerMpd::pushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::servicePushState Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: 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":"USB/M2/MUSIC/阿杜-离别.flac","trackType":"flac"} Jun 30 06:44:08 opera volumio[1021]: verbose: CURRENT POSITION 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::syncState stateService stop Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:44:08 opera volumio[1021]: info: No code Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:44:08 opera volumio[1021]: info: ------------------------------ 30ms Jun 30 06:44:08 opera volumio[1021]: error: updateQueue error: null Jun 30 06:44:08 opera volumio[1021]: info: Jun 30 06:44:08 opera volumio[1021]: ---------------------------- MPD announces system playlist update Jun 30 06:44:08 opera volumio[1021]: info: Ignoring MPD Status Update Jun 30 06:44:08 opera volumio[1021]: info: ------------------------------ 26ms Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand add "USB/M2/MUSIC/宋小睿 - 点歌的人.mp3" took 25 milliseconds Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Jun 30 06:44:08 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:44:08 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:44:08 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:44:08 opera volumio[1021]: info: ------------------------------ 11ms Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand play took 11 milliseconds Jun 30 06:44:08 opera volumio[1021]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%98%BF%E6%9D%9C/%E9%86%87%E6%83%85%E6%AD%8C/f4369bd2-0c53-4e17-a76b-f60d7ef289b4.jpg' Jun 30 06:44:08 opera volumio[1021]: info: Jun 30 06:44:08 opera volumio[1021]: ---------------------------- MPD announces state update: player Jun 30 06:44:08 opera volumio[1021]: info: ControllerMpd::getState Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand status took 2 milliseconds Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::parseState Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 06:44:08 opera volumio[1021]: info: Jun 30 06:44:08 opera volumio[1021]: ---------------------------- MPD announces state update: player Jun 30 06:44:08 opera volumio[1021]: info: ControllerMpd::getState Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jun 30 06:44:08 opera volumio[1021]: info: ControllerMpd::pushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::servicePushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"点歌的人","artist":"宋小睿","album":null,"uri":"USB/M2/MUSIC/宋小睿 - 点歌的人.mp3","trackType":"mp3"} Jun 30 06:44:08 opera volumio[1021]: verbose: CURRENT POSITION 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::syncState stateService play Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:44:08 opera volumio[1021]: info: ------------------------------ 18ms Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand status took 14 milliseconds Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::parseState Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 06:44:08 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:44:08 opera volumio[1021]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 30 06:44:08 opera volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jun 30 06:44:08 opera volumio[1021]: info: ControllerMpd::pushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::servicePushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"点歌的人","artist":"宋小睿","album":null,"uri":"USB/M2/MUSIC/宋小睿 - 点歌的人.mp3","trackType":"mp3"} Jun 30 06:44:08 opera volumio[1021]: verbose: CURRENT POSITION 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::syncState stateService play Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jun 30 06:44:08 opera volumio[1021]: info: Received an update from plugin. extracting info from payload Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:44:08 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:44:08 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:44:08 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:44:08 opera volumio[1021]: info: ------------------------------ 46ms Jun 30 06:44:08 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:44:08 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::volumioAddQueueItems Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::addQueueItems Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::addQueueItems Jun 30 06:45:03 opera volumio[1021]: info: Adding Item to queue: music-library/USB/M2/MUSIC/Track04.wav Jun 30 06:45:03 opera volumio[1021]: info: Exploding uri music-library/USB/M2/MUSIC/Track04.wav in service mpd Jun 30 06:45:03 opera volumio[1021]: info: ALBUMART /albumart?cacheid=915&web=//extralarge&path=%2Fmnt%2FUSB%2FM2%2FMUSIC%2FTrack04.wav&metadata=false Jun 30 06:45:03 opera volumio[1021]: info: URI /mnt/USB/M2/MUSIC/Track04.wav Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::saveQueue Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::volumioPushQueue Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::updateTrackBlock Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrackBlock Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::volumioPlay Jun 30 06:45:03 opera volumio[1021]: verbose: UNSET VOLATILE Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::play index 55 Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::stop Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 06:45:03 opera volumio[1021]: verbose: UNSET VOLATILE Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::stPlaybackTimer Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::updateTrackBlock Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrackBlock Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::serviceStop Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 54 Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::serviceStop Jun 30 06:45:03 opera volumio[1021]: info: ControllerMpd::stop Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Jun 30 06:45:03 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand stop took 82 milliseconds Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::play index undefined Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 55 Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::startPlaybackTimer Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 55 Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::clearAddPlayTracks USB/M2/MUSIC/Track04.wav Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Jun 30 06:45:03 opera volumio[1021]: info: Jun 30 06:45:03 opera volumio[1021]: ---------------------------- MPD announces state update: player Jun 30 06:45:03 opera volumio[1021]: info: ControllerMpd::getState Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand stop took 4 milliseconds Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Jun 30 06:45:03 opera volumio[1021]: info: Jun 30 06:45:03 opera volumio[1021]: ---------------------------- MPD announces system playlist update Jun 30 06:45:03 opera volumio[1021]: info: Ignoring MPD Status Update Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand status took 4 milliseconds Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand clear took 3 milliseconds Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::parseState Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand add "USB/M2/MUSIC/Track04.wav" Jun 30 06:45:03 opera volumio[1021]: error: updateQueue error: null Jun 30 06:45:03 opera volumio[1021]: info: Jun 30 06:45:03 opera volumio[1021]: ---------------------------- MPD announces system playlist update Jun 30 06:45:03 opera volumio[1021]: info: Ignoring MPD Status Update Jun 30 06:45:03 opera volumio[1021]: info: ------------------------------ 4ms Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand add "USB/M2/MUSIC/Track04.wav" took 2 milliseconds Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Jun 30 06:45:03 opera volumio[1021]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 30 06:45:03 opera volumio[1021]: info: ------------------------------ 11ms Jun 30 06:45:03 opera volumio[1021]: info: ------------------------------ 5ms Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand play took 2 milliseconds Jun 30 06:45:03 opera volumio[1021]: info: Jun 30 06:45:03 opera volumio[1021]: ---------------------------- MPD announces state update: player Jun 30 06:45:03 opera volumio[1021]: info: ControllerMpd::getState Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jun 30 06:45:03 opera volumio[1021]: info: Jun 30 06:45:03 opera volumio[1021]: ---------------------------- MPD announces state update: player Jun 30 06:45:03 opera volumio[1021]: info: ControllerMpd::getState Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand status took 2 milliseconds Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::parseState Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand status took 2 milliseconds Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::parseState Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jun 30 06:45:03 opera volumio[1021]: info: ControllerMpd::pushState Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::servicePushState Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 55 Jun 30 06:45:03 opera volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":124,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track04.wav","artist":null,"album":null,"uri":"USB/M2/MUSIC/Track04.wav","trackType":"wav"} Jun 30 06:45:03 opera volumio[1021]: verbose: CURRENT POSITION 55 Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::syncState stateService play Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 55 Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:45:03 opera volumio[1021]: info: ------------------------------ 20ms Jun 30 06:45:03 opera volumio[1021]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 30 06:45:03 opera volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jun 30 06:45:03 opera volumio[1021]: info: ControllerMpd::pushState Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::servicePushState Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 55 Jun 30 06:45:03 opera volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":124,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track04.wav","artist":null,"album":null,"uri":"USB/M2/MUSIC/Track04.wav","trackType":"wav"} Jun 30 06:45:03 opera volumio[1021]: verbose: CURRENT POSITION 55 Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::syncState stateService play Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jun 30 06:45:03 opera volumio[1021]: info: Received an update from plugin. extracting info from payload Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 55 Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:45:03 opera volumio[1021]: info: CoreStateMachine::pushState Jun 30 06:45:03 opera volumio[1021]: info: CorePlayQueue::getTrack 55 Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::volumioPushState Jun 30 06:45:03 opera volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 06:45:03 opera volumio[1021]: info: ------------------------------ 36ms Jun 30 06:45:03 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:45:03 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:45:03 opera volumio[1021]: info: Updating RAAT Signal Path Jun 30 06:45:29 opera kernel: rtk_btcoex: hci accept connreq, notify wifi page start Jun 30 06:45:29 opera kernel: rtk_btcoex: notify wifi page success end Jun 30 06:45:29 opera kernel: rtk_btcoex: io cap req, notify wifi pair start Jun 30 06:45:29 opera kernel: rtk_btcoex: link key notify, notify wifi pair end Jun 30 06:45:29 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Jun 30 06:45:29 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0002, PSM 0x0001, scid 0x0048 Jun 30 06:45:29 opera kernel: rtk_btcoex: PSM(0x0001) do not need parse Jun 30 06:45:29 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Jun 30 06:45:29 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0040, scid 0x0048, result 0x0000 Jun 30 06:45:29 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 30 06:45:29 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0002, dcid 0x0040, scid 0x0048 Jun 30 06:45:29 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0002, dcid 0x0040, scid 0x0048, dir 0 Jun 30 06:45:29 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Jun 30 06:45:29 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Jun 30 06:45:29 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0002, PSM 0x0001, scid 0x0049 Jun 30 06:45:29 opera kernel: rtk_btcoex: PSM(0x0001) do not need parse Jun 30 06:45:29 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0040, scid 0x0049, result 0x0000 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0002, dcid 0x0040, scid 0x0049 Jun 30 06:45:30 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0002, dcid 0x0040, scid 0x0049, dir 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Jun 30 06:45:30 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0002, PSM 0x0001, scid 0x004a Jun 30 06:45:30 opera kernel: rtk_btcoex: PSM(0x0001) do not need parse Jun 30 06:45:30 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0040, scid 0x004a, result 0x0000 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0002, dcid 0x0040, scid 0x004a Jun 30 06:45:30 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0002, dcid 0x0040, scid 0x004a, dir 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Jun 30 06:45:30 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0002, PSM 0x0019, scid 0x004b Jun 30 06:45:30 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0040, scid 0x004b, result 0x0001 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 1 Jun 30 06:45:30 opera kernel: rtk_btcoex: TX l2cap conn req, hndl 0x0002, PSM 0x0001, scid 0x0041 Jun 30 06:45:30 opera kernel: rtk_btcoex: PSM(0x0001) do not need parse Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: RX l2cap conn rsp, hndl 0x0002, dcid 0x004c, scid 0x0041, result 0x0000 Jun 30 06:45:30 opera bluetoothd[903]: GAP and GATT are mandatory Jun 30 06:45:30 opera bluetoothd[903]: gap-gatt-profile profile probe failed for E4:0E:EE:64:C7:3B Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Jun 30 06:45:30 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0040, scid 0x004b, result 0x0000 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap connection success, update connection Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: is_add 1, profile_index 2 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x04 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 1 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Jun 30 06:45:30 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Jun 30 06:45:30 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0002 Jun 30 06:45:30 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x04 Jun 30 06:45:30 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00 Jun 30 06:45:30 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0002, PSM 0x0019, scid 0x004d Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Jun 30 06:45:30 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0042, scid 0x004d, result 0x0001 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Jun 30 06:45:30 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0042, scid 0x004d, result 0x0000 Jun 30 06:45:30 opera kernel: rtk_btcoex: l2cap connection success, update connection Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: is_add 1, profile_index 2 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x04 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 2 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Jun 30 06:45:30 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Jun 30 06:45:31 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:32 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:33 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 1 Jun 30 06:45:33 opera kernel: rtk_btcoex: TX l2cap disconn req, hndl 0x0002, dcid 0x004c, scid 0x0041 Jun 30 06:45:33 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0002, dcid 0x004c, scid 0x0041, dir 1 Jun 30 06:45:33 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 1 Jun 30 06:45:33 opera kernel: rtk_btcoex: TX l2cap conn req, hndl 0x0002, PSM 0x0017, scid 0x0043 Jun 30 06:45:33 opera kernel: rtk_btcoex: PSM(0x0017) do not need parse Jun 30 06:45:33 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 0 Jun 30 06:45:33 opera kernel: rtk_btcoex: RX l2cap conn rsp, hndl 0x0002, dcid 0x004e, scid 0x0043, result 0x0000 Jun 30 06:45:33 opera kernel: input: E4:0E:EE:64:C7:3B as /devices/virtual/input/input3 Jun 30 06:45:33 opera kernel: rtk_btcoex: l2cap op 2, len 16, out 0 Jun 30 06:45:33 opera kernel: rtk_btcoex: RX l2cap conn req, hndl 0x0002, PSM 0x0001, scid 0x004f Jun 30 06:45:33 opera kernel: rtk_btcoex: PSM(0x0001) do not need parse Jun 30 06:45:33 opera kernel: rtk_btcoex: l2cap op 3, len 20, out 1 Jun 30 06:45:33 opera kernel: rtk_btcoex: TX l2cap conn rsp, hndl 0x0002, dcid 0x0041, scid 0x004f, result 0x0000 Jun 30 06:45:33 opera volumio[1021]: ------------------------------------ BT MESSAGE: BT STATUS: paused Jun 30 06:45:33 opera volumio[1021]: BT PLUGIN MESSAGE: Playing: false Jun 30 06:45:33 opera volumio[1021]: BT PLUGIN MESSAGE: VOLATILE: undefined Jun 30 06:45:33 opera volumio[1021]: BT PLUGIN MESSAGE: STATE:undefined Jun 30 06:45:33 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Jun 30 06:45:33 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0002, dcid 0x0041, scid 0x004f Jun 30 06:45:33 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0002, dcid 0x0041, scid 0x004f, dir 0 Jun 30 06:45:33 opera volumio[1021]: BT PLUGIN MESSAGE: Duration is 239000 Jun 30 06:45:33 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:34 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:35 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:36 opera volumio[1021]: ------------------------------------ BT MESSAGE: BT STATUS: stopped Jun 30 06:45:36 opera volumio[1021]: BT PLUGIN MESSAGE: Playing: false Jun 30 06:45:36 opera volumio[1021]: BT PLUGIN MESSAGE: VOLATILE: undefined Jun 30 06:45:36 opera volumio[1021]: BT PLUGIN MESSAGE: STATE:undefined Jun 30 06:45:36 opera volumio[1021]: BT PLUGIN MESSAGE: Duration is 0 Jun 30 06:45:36 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:37 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:37 opera kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 800 Jun 30 06:45:37 opera kernel: rtk_btcoex: HID not connected, nothing to be down Jun 30 06:45:38 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:38 opera kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 0 Jun 30 06:45:38 opera kernel: rtk_btcoex: HID not connected, nothing to be down Jun 30 06:45:39 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:40 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:41 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:42 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:43 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:44 opera volumio[1021]: BT PLUGIN MESSAGE: Duration is 239000 Jun 30 06:45:44 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:45 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:45 opera kernel: rtk_btcoex: update_hid_active_state: handle 0x0002, interval 800 Jun 30 06:45:45 opera kernel: rtk_btcoex: HID not connected, nothing to be down Jun 30 06:45:46 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:47 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:48 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:49 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:50 opera kernel: rtk_btcoex: count_a2dp_packet_timeout: a2dp_packet_count 0 Jun 30 06:45:50 opera volumio[1021]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 06:45:50 opera volumio[1021]: { Error: connect ETIMEDOUT 103.97.3.19:443 Jun 30 06:45:50 opera volumio[1021]: at Object._errnoException (util.js:1022:11) Jun 30 06:45:50 opera volumio[1021]: at _exceptionWithHostPort (util.js:1044:20) Jun 30 06:45:50 opera volumio[1021]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 30 06:45:50 opera volumio[1021]: code: 'ETIMEDOUT', Jun 30 06:45:50 opera volumio[1021]: errno: 'ETIMEDOUT', Jun 30 06:45:50 opera volumio[1021]: syscall: 'connect', Jun 30 06:45:50 opera volumio[1021]: address: '103.97.3.19', Jun 30 06:45:50 opera volumio[1021]: port: 443 } Jun 30 06:45:50 opera volumio[1021]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 06:45:51 opera sudo[3857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 06:44 Jun 30 06:45:51 opera sudo[3857]: 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"