-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sat 2024-10-19 16:04:15 CST. -- Oct 19 16:03:07 volumio volumio[1008]: info: MyVolumio login type: Token Oct 19 16:03:08 volumio volumio[1008]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/aespa/Drama%20-%20The%204th%20Mini%20Album/6bdda7bb-f4f1-4d97-820c-7f3e096738f9.jpg' Oct 19 16:03:09 volumio volumio[1008]: verbose: New Socket.io Connection to 192.168.0.107 from 192.168.0.113 UA: Mozilla/5.0 (Linux; U; Android 14; zh-CN; 2210132C Build/UKQ1.230804.001) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/100.0.4896.58 Quark/7.4.0.670 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 19 16:03:09 volumio volumio[1008]: info: CoreCommandRouter::volumioGetState Oct 19 16:03:09 volumio volumio[1008]: info: CorePlayQueue::getTrack 4 Oct 19 16:03:09 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 19 16:03:09 volumio volumio[1008]: info: Listing playlists Oct 19 16:03:09 volumio volumio[1008]: info: CoreCommandRouter::volumioGetQueue Oct 19 16:03:09 volumio volumio[1008]: info: CoreStateMachine::getQueue Oct 19 16:03:09 volumio volumio[1008]: info: CorePlayQueue::getQueue Oct 19 16:03:09 volumio volumio[1008]: info: CoreCommandRouter::volumioGetVisibleSources Oct 19 16:03:09 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 16:03:10 volumio volumio[1008]: info: Preload queue cleared Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::ClearQueue Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::stop Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::stPlaybackTimer Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::updateTrackBlock Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrackBlock Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 4 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::serviceStop Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 4 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::serviceStop Oct 19 16:03:10 volumio volumio[1008]: info: ControllerMpd::stop Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::clearPlayQueue Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::saveQueue Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushQueue Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::addQueueItems Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::addQueueItems Oct 19 16:03:10 volumio volumio[1008]: info: Preload queue cleared Oct 19 16:03:10 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/내가 제일 잘 나가 - 2NE1.flac Oct 19 16:03:10 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/내가 제일 잘 나가 - 2NE1.flac Oct 19 16:03:10 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/I Don't Care - 2NE1.flac Oct 19 16:03:10 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/I Don't Care - 2NE1.flac Oct 19 16:03:10 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Armageddon - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Armageddon - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Black Mamba - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Black Mamba - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Drama - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Drama - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Next Level - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Next Level - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Supernova - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Supernova - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/도깨비불 (Illusion) - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/도깨비불 (Illusion) - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushQueue Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::saveQueue Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::updateTrackBlock Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrackBlock Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPlay Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::play index 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::stop Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::play index undefined Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::startPlaybackTimer Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::clearAddPlayTracks USB/music/喵喵/Supernova - aespa.flac Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 16:03:10 volumio volumio[1008]: info: Oct 19 16:03:10 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:10 volumio volumio[1008]: info: sendMpdCommand stop took 69 milliseconds Oct 19 16:03:10 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:10 volumio volumio[1008]: info: sendMpdCommand stop took 33 milliseconds Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand clear Oct 19 16:03:10 volumio volumio[1008]: info: Oct 19 16:03:10 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:10 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:10 volumio volumio[1008]: info: Oct 19 16:03:10 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:10 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:10 volumio volumio[1008]: info: Oct 19 16:03:10 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:10 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:10 volumio volumio[1008]: info: Oct 19 16:03:10 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:10 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:10 volumio volumio[1008]: info: sendMpdCommand status took 22 milliseconds Oct 19 16:03:10 volumio volumio[1008]: info: sendMpdCommand clear took 20 milliseconds Oct 19 16:03:10 volumio volumio[1008]: info: sendMpdCommand status took 19 milliseconds Oct 19 16:03:10 volumio volumio[1008]: info: sendMpdCommand status took 15 milliseconds Oct 19 16:03:10 volumio volumio[1008]: info: sendMpdCommand status took 15 milliseconds Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand add "USB/music/喵喵/Supernova - aespa.flac" Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:10 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:10 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:03:10 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: No code Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:03:10 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: No code Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:03:10 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:10 volumio volumio[1008]: info: No code Oct 19 16:03:10 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:10 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:10 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 122ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 120ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 119ms Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:11 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:11 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:11 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:11 volumio volumio[1008]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 19 16:03:11 volumio volumio[1008]: error: updateQueue error: null Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:11 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 116ms Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 114 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand add "USB/music/喵喵/Supernova - aespa.flac" took 114 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 9ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 8ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 7ms Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand play Oct 19 16:03:11 volumio volumio[1008]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 141ms Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:11 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:11 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:11 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 48ms Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand play took 45 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 44ms Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 44ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 42ms Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand status took 30 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand status took 30 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand status took 28 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand status took 27 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand status took 25 milliseconds Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:11 volumio volumio[1008]: info: Oct 19 16:03:11 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand status took 8 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand status took 6 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand status took 6 milliseconds Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":179,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2238 Kbps","isStreaming":false,"title":"Supernova","artist":"aespa","album":"Supernova","uri":"USB/music/喵喵/Supernova - aespa.flac","trackType":"flac"} Oct 19 16:03:11 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":179,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2238 Kbps","isStreaming":false,"title":"Supernova","artist":"aespa","album":"Supernova","uri":"USB/music/喵喵/Supernova - aespa.flac","trackType":"flac"} Oct 19 16:03:11 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:11 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":179,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2238 Kbps","isStreaming":false,"title":"Supernova","artist":"aespa","album":"Supernova","uri":"USB/music/喵喵/Supernova - aespa.flac","trackType":"flac"} Oct 19 16:03:11 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:11 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":179,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2238 Kbps","isStreaming":false,"title":"Supernova","artist":"aespa","album":"Supernova","uri":"USB/music/喵喵/Supernova - aespa.flac","trackType":"flac"} Oct 19 16:03:11 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:11 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":179,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2238 Kbps","isStreaming":false,"title":"Supernova","artist":"aespa","album":"Supernova","uri":"USB/music/喵喵/Supernova - aespa.flac","trackType":"flac"} Oct 19 16:03:11 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:11 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 70ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 143ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 141ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 141ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 140ms Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 105 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 105 milliseconds Oct 19 16:03:11 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 104 milliseconds Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":179,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2238 Kbps","isStreaming":false,"title":"Supernova","artist":"aespa","album":"Supernova","uri":"USB/music/喵喵/Supernova - aespa.flac","trackType":"flac"} Oct 19 16:03:11 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:11 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":179,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2238 Kbps","isStreaming":false,"title":"Supernova","artist":"aespa","album":"Supernova","uri":"USB/music/喵喵/Supernova - aespa.flac","trackType":"flac"} Oct 19 16:03:11 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:11 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":179,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2238 Kbps","isStreaming":false,"title":"Supernova","artist":"aespa","album":"Supernova","uri":"USB/music/喵喵/Supernova - aespa.flac","trackType":"flac"} Oct 19 16:03:11 volumio volumio[1008]: verbose: CURRENT POSITION 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:11 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:11 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:11 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 191ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 191ms Oct 19 16:03:11 volumio volumio[1008]: info: ------------------------------ 191ms Oct 19 16:03:12 volumio volumio[1008]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11 Oct 19 16:03:12 volumio volumio[1008]: info: CoreCommandRouter::volumioGetState Oct 19 16:03:12 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:12 volumio volumio[1008]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/aespa/Supernova/e73a01b7-71b0-4993-9fb6-dedf97346acf.jpg' Oct 19 16:03:19 volumio volumio[1008]: info: Preload queue cleared Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::ClearQueue Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::stop Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::stPlaybackTimer Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::updateTrackBlock Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrackBlock Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::serviceStop Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 6 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::serviceStop Oct 19 16:03:19 volumio volumio[1008]: info: ControllerMpd::stop Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::clearPlayQueue Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::saveQueue Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushQueue Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::addQueueItems Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::addQueueItems Oct 19 16:03:19 volumio volumio[1008]: info: Preload queue cleared Oct 19 16:03:19 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/내가 제일 잘 나가 - 2NE1.flac Oct 19 16:03:19 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/내가 제일 잘 나가 - 2NE1.flac Oct 19 16:03:19 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/I Don't Care - 2NE1.flac Oct 19 16:03:19 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/I Don't Care - 2NE1.flac Oct 19 16:03:19 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Armageddon - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Armageddon - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Black Mamba - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Black Mamba - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Drama - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Drama - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Next Level - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Next Level - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/Supernova - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/Supernova - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/喵喵/도깨비불 (Illusion) - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/喵喵/도깨비불 (Illusion) - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushQueue Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::saveQueue Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::updateTrackBlock Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrackBlock Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPlay Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::play index 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::stop Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::play index undefined Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::startPlaybackTimer Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::clearAddPlayTracks USB/music/喵喵/Armageddon - aespa.flac Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 16:03:19 volumio volumio[1008]: info: Oct 19 16:03:19 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:19 volumio volumio[1008]: info: sendMpdCommand stop took 38 milliseconds Oct 19 16:03:19 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:19 volumio volumio[1008]: info: sendMpdCommand stop took 8 milliseconds Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand clear Oct 19 16:03:19 volumio volumio[1008]: info: Oct 19 16:03:19 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:19 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:19 volumio volumio[1008]: info: Oct 19 16:03:19 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:19 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:19 volumio volumio[1008]: info: Oct 19 16:03:19 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:19 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:19 volumio volumio[1008]: info: Oct 19 16:03:19 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:19 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:19 volumio volumio[1008]: info: sendMpdCommand status took 6 milliseconds Oct 19 16:03:19 volumio volumio[1008]: info: sendMpdCommand clear took 6 milliseconds Oct 19 16:03:19 volumio volumio[1008]: info: sendMpdCommand status took 4 milliseconds Oct 19 16:03:19 volumio volumio[1008]: info: sendMpdCommand status took 3 milliseconds Oct 19 16:03:19 volumio volumio[1008]: info: sendMpdCommand status took 2 milliseconds Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand add "USB/music/喵喵/Armageddon - aespa.flac" Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:19 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:19 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:03:19 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: No code Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:03:19 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: No code Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:03:19 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:19 volumio volumio[1008]: info: No code Oct 19 16:03:19 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:19 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:19 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 110ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 110ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 109ms Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:20 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:20 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:20 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:20 volumio volumio[1008]: error: updateQueue error: null Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:20 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 134ms Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 132 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand add "USB/music/喵喵/Armageddon - aespa.flac" took 132 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 27ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 25ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 25ms Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand play Oct 19 16:03:20 volumio volumio[1008]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 143ms Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:20 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:20 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:03:20 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 63ms Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand play took 60 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 58ms Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 56ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 52ms Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:20 volumio volumio[1008]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand status took 16 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand status took 15 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand status took 15 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand status took 14 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand status took 13 milliseconds Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:20 volumio volumio[1008]: info: Oct 19 16:03:20 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand status took 13 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand status took 13 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand status took 12 milliseconds Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":196,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2148 Kbps","isStreaming":false,"title":"Armageddon","artist":"aespa","album":"Armageddon - The 1st Album","uri":"USB/music/喵喵/Armageddon - aespa.flac","trackType":"flac"} Oct 19 16:03:20 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":196,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2148 Kbps","isStreaming":false,"title":"Armageddon","artist":"aespa","album":"Armageddon - The 1st Album","uri":"USB/music/喵喵/Armageddon - aespa.flac","trackType":"flac"} Oct 19 16:03:20 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:20 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":196,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2148 Kbps","isStreaming":false,"title":"Armageddon","artist":"aespa","album":"Armageddon - The 1st Album","uri":"USB/music/喵喵/Armageddon - aespa.flac","trackType":"flac"} Oct 19 16:03:20 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:20 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":196,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2148 Kbps","isStreaming":false,"title":"Armageddon","artist":"aespa","album":"Armageddon - The 1st Album","uri":"USB/music/喵喵/Armageddon - aespa.flac","trackType":"flac"} Oct 19 16:03:20 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:20 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":196,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2148 Kbps","isStreaming":false,"title":"Armageddon","artist":"aespa","album":"Armageddon - The 1st Album","uri":"USB/music/喵喵/Armageddon - aespa.flac","trackType":"flac"} Oct 19 16:03:20 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:20 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 69ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 141ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 139ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 139ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 139ms Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 111 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 111 milliseconds Oct 19 16:03:20 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 111 milliseconds Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:20 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":196,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2148 Kbps","isStreaming":false,"title":"Armageddon","artist":"aespa","album":"Armageddon - The 1st Album","uri":"USB/music/喵喵/Armageddon - aespa.flac","trackType":"flac"} Oct 19 16:03:20 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:20 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":196,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2148 Kbps","isStreaming":false,"title":"Armageddon","artist":"aespa","album":"Armageddon - The 1st Album","uri":"USB/music/喵喵/Armageddon - aespa.flac","trackType":"flac"} Oct 19 16:03:20 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:20 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":196,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2148 Kbps","isStreaming":false,"title":"Armageddon","artist":"aespa","album":"Armageddon - The 1st Album","uri":"USB/music/喵喵/Armageddon - aespa.flac","trackType":"flac"} Oct 19 16:03:20 volumio volumio[1008]: verbose: CURRENT POSITION 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:03:20 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:03:20 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:20 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 208ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 208ms Oct 19 16:03:20 volumio volumio[1008]: info: ------------------------------ 207ms Oct 19 16:03:21 volumio volumio[1008]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 12 Oct 19 16:03:21 volumio volumio[1008]: info: CoreCommandRouter::volumioGetState Oct 19 16:03:21 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:21 volumio volumio[1008]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/aespa/Armageddon%20-%20The%201st%20Album/b5a35830-dc62-4a68-be99-e8cfe55d60cd.jpg' Oct 19 16:03:37 volumio volumio[1008]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Oct 19 16:03:37 volumio volumio[1008]: info: Retrying Login Due to Network Error Oct 19 16:03:47 volumio volumio[1008]: info: MyVolumio login type: Token Oct 19 16:03:48 volumio volumio[1008]: info: peppy_screensaver: Start PeppyMeter Oct 19 16:03:55 volumio volumio[1008]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 19 16:03:55 volumio volumio[1008]: info: CoreCommandRouter::volumioGetState Oct 19 16:03:55 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:03:55 volumio volumio[1008]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/aespa/Armageddon%20-%20The%201st%20Album/72a9d29f-a364-4320-9a14-77c9a5977389.jpg' Oct 19 16:03:55 volumio volumio[1008]: info: peppy_screensaver: Start PeppyMeter Oct 19 16:04:00 volumio volumio[1008]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 19 16:04:00 volumio volumio[1008]: info: CoreCommandRouter::volumioGetState Oct 19 16:04:00 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:04:00 volumio volumio[1008]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/aespa/Armageddon%20-%20The%201st%20Album/72a9d29f-a364-4320-9a14-77c9a5977389.jpg' Oct 19 16:04:02 volumio volumio[1008]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/aespa/Armageddon%20-%20The%201st%20Album/cf0d175d-cafb-4aea-859c-095d227fc1c8.jpg' Oct 19 16:04:02 volumio volumio[1008]: verbose: New Socket.io Connection to 192.168.0.107 from 192.168.0.113 UA: Mozilla/5.0 (Linux; U; Android 14; zh-CN; 2210132C Build/UKQ1.230804.001) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/100.0.4896.58 Quark/7.4.0.670 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 19 16:04:02 volumio volumio[1008]: info: CoreCommandRouter::volumioGetState Oct 19 16:04:02 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:04:02 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 19 16:04:02 volumio volumio[1008]: info: Listing playlists Oct 19 16:04:02 volumio volumio[1008]: info: CoreCommandRouter::volumioGetQueue Oct 19 16:04:02 volumio volumio[1008]: info: CoreStateMachine::getQueue Oct 19 16:04:02 volumio volumio[1008]: info: CorePlayQueue::getQueue Oct 19 16:04:02 volumio volumio[1008]: info: CoreCommandRouter::volumioGetVisibleSources Oct 19 16:04:02 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 16:04:06 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 19 16:04:06 volumio volumio[1008]: info: CURURI: music-library/USB/music/儿歌多多 Oct 19 16:04:06 volumio volumio[1008]: info: Preload queue cleared Oct 19 16:04:06 volumio volumio[1008]: info: Preloading song: music-library/USB/music/儿歌多多/鲨鱼宝宝 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Preloading song: music-library/USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Preloading song: music-library/USB/music/儿歌多多/健康歌 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Preloading song: music-library/USB/music/儿歌多多/小老鼠上灯台 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Preloading song: music-library/USB/music/儿歌多多/拔萝卜 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Preloading song: music-library/USB/music/儿歌多多/捉泥鳅 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Preloading song: music-library/USB/music/儿歌多多/爱我你就抱抱我 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Preloading song: music-library/USB/music/儿歌多多/白龙马 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Exploding uri music-library/USB/music/儿歌多多/鲨鱼宝宝 - 儿歌多多.flac in service mpd Oct 19 16:04:06 volumio volumio[1008]: info: ALBUMART /albumart?cacheid=292&web=%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A/%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%E5%84%BF%E6%AD%8C%E5%A4%A7%E5%85%A8/extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%2F%E9%B2%A8%E9%B1%BC%E5%AE%9D%E5%AE%9D%20-%20%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A.flac&metadata=false Oct 19 16:04:06 volumio volumio[1008]: info: URI /mnt/USB/music/儿歌多多/鲨鱼宝宝 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Exploding uri music-library/USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac in service mpd Oct 19 16:04:06 volumio volumio[1008]: info: ALBUMART /albumart?cacheid=292&web=%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A/%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%E7%BB%8F%E5%85%B8%E5%84%BF%E6%AD%8C2/extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%2F%E4%B8%80%E5%8F%AA%E5%93%88%E5%B7%B4%E7%8B%97%20-%20%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A.flac&metadata=false Oct 19 16:04:06 volumio volumio[1008]: info: URI /mnt/USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Exploding uri music-library/USB/music/儿歌多多/健康歌 - 儿歌多多.flac in service mpd Oct 19 16:04:06 volumio volumio[1008]: info: ALBUMART /albumart?cacheid=292&web=%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A/%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%E7%BB%8F%E5%85%B8%E5%84%BF%E6%AD%8C2/extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%2F%E5%81%A5%E5%BA%B7%E6%AD%8C%20-%20%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A.flac&metadata=false Oct 19 16:04:06 volumio volumio[1008]: info: URI /mnt/USB/music/儿歌多多/健康歌 - 儿歌多多.flac Oct 19 16:04:06 volumio volumio[1008]: info: Exploding uri music-library/USB/music/儿歌多多/小老鼠上灯台 - 儿歌多多.flac in service mpd Oct 19 16:04:06 volumio volumio[1008]: info: ALBUMART /albumart?cacheid=292&web=%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A/%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%E7%BB%8F%E5%85%B8%E5%84%BF%E6%AD%8C2/extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%2F%E5%B0%8F%E8%80%81%E9%BC%A0%E4%B8%8A%E7%81%AF%E5%8F%B0%20-%20%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A.flac&metadata=false Oct 19 16:04:06 volumio volumio[1008]: info: URI /mnt/USB/music/儿歌多多/小老鼠上灯台 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Exploding uri music-library/USB/music/儿歌多多/拔萝卜 - 儿歌多多.flac in service mpd Oct 19 16:04:07 volumio volumio[1008]: info: ALBUMART /albumart?cacheid=292&web=%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A/%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%E7%BB%8F%E5%85%B8%E5%84%BF%E6%AD%8C2/extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%2F%E6%8B%94%E8%90%9D%E5%8D%9C%20-%20%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A.flac&metadata=false Oct 19 16:04:07 volumio volumio[1008]: info: URI /mnt/USB/music/儿歌多多/拔萝卜 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Exploding uri music-library/USB/music/儿歌多多/捉泥鳅 - 儿歌多多.flac in service mpd Oct 19 16:04:07 volumio volumio[1008]: info: ALBUMART /albumart?cacheid=292&web=%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A/%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%E7%BB%8F%E5%85%B8%E5%84%BF%E6%AD%8C2/extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%2F%E6%8D%89%E6%B3%A5%E9%B3%85%20-%20%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A.flac&metadata=false Oct 19 16:04:07 volumio volumio[1008]: info: URI /mnt/USB/music/儿歌多多/捉泥鳅 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Exploding uri music-library/USB/music/儿歌多多/爱我你就抱抱我 - 儿歌多多.flac in service mpd Oct 19 16:04:07 volumio volumio[1008]: info: ALBUMART /albumart?cacheid=292&web=%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A/%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%E7%BB%8F%E5%85%B8%E5%84%BF%E6%AD%8C2/extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%2F%E7%88%B1%E6%88%91%E4%BD%A0%E5%B0%B1%E6%8A%B1%E6%8A%B1%E6%88%91%20-%20%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A.flac&metadata=false Oct 19 16:04:07 volumio volumio[1008]: info: URI /mnt/USB/music/儿歌多多/爱我你就抱抱我 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Exploding uri music-library/USB/music/儿歌多多/白龙马 - 儿歌多多.flac in service mpd Oct 19 16:04:07 volumio volumio[1008]: info: ALBUMART /albumart?cacheid=292&web=%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A/%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%E7%BB%8F%E5%85%B8%E5%84%BF%E6%AD%8C2/extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A%2F%E7%99%BD%E9%BE%99%E9%A9%AC%20-%20%E5%84%BF%E6%AD%8C%E5%A4%9A%E5%A4%9A.flac&metadata=false Oct 19 16:04:07 volumio volumio[1008]: info: URI /mnt/USB/music/儿歌多多/白龙马 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Preload queue cleared Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::ClearQueue Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::stop Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::stPlaybackTimer Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::updateTrackBlock Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrackBlock Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::serviceStop Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 2 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::serviceStop Oct 19 16:04:07 volumio volumio[1008]: info: ControllerMpd::stop Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::clearPlayQueue Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::saveQueue Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushQueue Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::addQueueItems Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::addQueueItems Oct 19 16:04:07 volumio volumio[1008]: info: Preload queue cleared Oct 19 16:04:07 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/儿歌多多/鲨鱼宝宝 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/儿歌多多/鲨鱼宝宝 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/儿歌多多/健康歌 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/儿歌多多/健康歌 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/儿歌多多/小老鼠上灯台 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/儿歌多多/小老鼠上灯台 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/儿歌多多/拔萝卜 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/儿歌多多/拔萝卜 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/儿歌多多/捉泥鳅 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/儿歌多多/捉泥鳅 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/儿歌多多/爱我你就抱抱我 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/儿歌多多/爱我你就抱抱我 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Adding Item to queue: music-library/USB/music/儿歌多多/白龙马 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: Using cached record of: music-library/USB/music/儿歌多多/白龙马 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushQueue Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::saveQueue Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::updateTrackBlock Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrackBlock Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPlay Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::play index 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::stop Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::play index undefined Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::startPlaybackTimer Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::clearAddPlayTracks USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 16:04:07 volumio volumio[1008]: info: Oct 19 16:04:07 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:07 volumio volumio[1008]: info: sendMpdCommand stop took 59 milliseconds Oct 19 16:04:07 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:07 volumio volumio[1008]: info: sendMpdCommand stop took 32 milliseconds Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand clear Oct 19 16:04:07 volumio volumio[1008]: info: Oct 19 16:04:07 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:07 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:07 volumio volumio[1008]: info: Oct 19 16:04:07 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:07 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:07 volumio volumio[1008]: info: Oct 19 16:04:07 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:07 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:07 volumio volumio[1008]: info: Oct 19 16:04:07 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:04:07 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:04:07 volumio volumio[1008]: info: sendMpdCommand status took 11 milliseconds Oct 19 16:04:07 volumio volumio[1008]: info: sendMpdCommand clear took 9 milliseconds Oct 19 16:04:07 volumio volumio[1008]: info: sendMpdCommand status took 8 milliseconds Oct 19 16:04:07 volumio volumio[1008]: info: sendMpdCommand status took 5 milliseconds Oct 19 16:04:07 volumio volumio[1008]: info: sendMpdCommand status took 4 milliseconds Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand add "USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac" Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:07 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:07 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:04:07 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: No code Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:04:07 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: No code Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 19 16:04:07 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::syncState stateService stop Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:07 volumio volumio[1008]: info: No code Oct 19 16:04:07 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:07 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:07 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 122ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 120ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 123ms Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:04:08 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:04:08 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:04:08 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:04:08 volumio volumio[1008]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 19 16:04:08 volumio volumio[1008]: error: updateQueue error: null Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:04:08 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 129ms Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 126 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand add "USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac" took 127 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 9ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 8ms Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand play Oct 19 16:04:08 volumio volumio[1008]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 145ms Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:04:08 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:04:08 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces system playlist update Oct 19 16:04:08 volumio volumio[1008]: info: Ignoring MPD Status Update Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 43ms Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand play took 40 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 39ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 38ms Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 38ms Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand status took 8 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand status took 8 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand status took 7 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand status took 6 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand status took 5 milliseconds Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:08 volumio volumio[1008]: info: Oct 19 16:04:08 volumio volumio[1008]: ---------------------------- MPD announces state update: player Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::getState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand status took 4 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand status took 4 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand status took 3 milliseconds Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseState Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":129,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"一只哈巴狗","artist":"儿歌多多","album":"儿歌多多经典儿歌2","uri":"USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac","trackType":"flac"} Oct 19 16:04:08 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":129,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"一只哈巴狗","artist":"儿歌多多","album":"儿歌多多经典儿歌2","uri":"USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac","trackType":"flac"} Oct 19 16:04:08 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:04:08 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":129,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"一只哈巴狗","artist":"儿歌多多","album":"儿歌多多经典儿歌2","uri":"USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac","trackType":"flac"} Oct 19 16:04:08 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:04:08 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":129,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"一只哈巴狗","artist":"儿歌多多","album":"儿歌多多经典儿歌2","uri":"USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac","trackType":"flac"} Oct 19 16:04:08 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:04:08 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":129,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"一只哈巴狗","artist":"儿歌多多","album":"儿歌多多经典儿歌2","uri":"USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac","trackType":"flac"} Oct 19 16:04:08 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:04:08 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 68ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 145ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 146ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 146ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 146ms Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 135 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 135 milliseconds Oct 19 16:04:08 volumio volumio[1008]: info: sendMpdCommand playlistinfo took 135 milliseconds Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: verbose: ControllerMpd::parseTrackInfo Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":129,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"一只哈巴狗","artist":"儿歌多多","album":"儿歌多多经典儿歌2","uri":"USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac","trackType":"flac"} Oct 19 16:04:08 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:04:08 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":129,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"一只哈巴狗","artist":"儿歌多多","album":"儿歌多多经典儿歌2","uri":"USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac","trackType":"flac"} Oct 19 16:04:08 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:04:08 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: ControllerMpd::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::servicePushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":129,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"一只哈巴狗","artist":"儿歌多多","album":"儿歌多多经典儿歌2","uri":"USB/music/儿歌多多/一只哈巴狗 - 儿歌多多.flac","trackType":"flac"} Oct 19 16:04:08 volumio volumio[1008]: verbose: CURRENT POSITION 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState stateService play Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::syncState currentStatus play Oct 19 16:04:08 volumio volumio[1008]: info: Received an update from plugin. extracting info from payload Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: CoreStateMachine::pushState Oct 19 16:04:08 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:08 volumio volumio[1008]: info: CoreCommandRouter::volumioPushState Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 281ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 280ms Oct 19 16:04:08 volumio volumio[1008]: info: ------------------------------ 280ms Oct 19 16:04:09 volumio volumio[1008]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11 Oct 19 16:04:09 volumio volumio[1008]: info: CoreCommandRouter::volumioGetState Oct 19 16:04:09 volumio volumio[1008]: info: CorePlayQueue::getTrack 1 Oct 19 16:04:15 volumio volumio[1008]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 16:04:15 volumio volumio[1008]: Error: connect ETIMEDOUT 192.133.77.145:443 Oct 19 16:04:15 volumio volumio[1008]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Oct 19 16:04:15 volumio volumio[1008]: errno: -110, Oct 19 16:04:15 volumio volumio[1008]: code: 'ETIMEDOUT', Oct 19 16:04:15 volumio volumio[1008]: syscall: 'connect', Oct 19 16:04:15 volumio volumio[1008]: address: '192.133.77.145', Oct 19 16:04:15 volumio volumio[1008]: port: 443 Oct 19 16:04:15 volumio volumio[1008]: } Oct 19 16:04:15 volumio volumio[1008]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 16:04:15 volumio sudo[2978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 16:03 Oct 19 16:04:15 volumio sudo[2978]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"