-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sat 2024-08-31 23:08:17 CST. -- Aug 31 23:07:00 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:00 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:00 volumio volumio[972]: info: Listing playlists Aug 31 23:07:00 volumio volumio[972]: info: Listing playlists Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::ClearQueue Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::stop Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::stPlaybackTimer Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::updateTrackBlock Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrackBlock Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::serviceStop Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::serviceStop Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::stop Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::clearPlayQueue Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::saveQueue Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushQueue Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::addQueueItems Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::addQueueItems Aug 31 23:07:07 volumio volumio[972]: info: Preload queue cleared Aug 31 23:07:07 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/music/昨日重现.mp3 Aug 31 23:07:07 volumio volumio[972]: info: Exploding uri music-library/INTERNAL/music_mp3/music/昨日重现.mp3 in service mpd Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ALBUMART /albumart?cacheid=642&web=/%E4%B9%A1%E6%9D%91%E4%B9%8B%E6%AD%8C%20Disc%201/medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2Fmusic%2F%E6%98%A8%E6%97%A5%E9%87%8D%E7%8E%B0.mp3&metadata=false Aug 31 23:07:07 volumio volumio[972]: info: URI /mnt/INTERNAL/music_mp3/music/昨日重现.mp3 Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand stop took 32 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushQueue Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::saveQueue Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::updateTrackBlock Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrackBlock Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPlay Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::play index 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::stop Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::play index undefined Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::startPlaybackTimer Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/music/昨日重现.mp3 Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 33 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand stop took 9 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 6 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 4 milliseconds Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:07 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand clear took 10 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/music/昨日重现.mp3" Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"无情的情书.mp3","artist":"Salen","album":null,"uri":"INTERNAL/music_mp3/动力火车/无情的情书.mp3","trackType":"mp3"} Aug 31 23:07:07 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: No code Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 31 23:07:07 volumio volumio[972]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 86ms Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 56ms Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 59ms Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:07 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:07 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:07 volumio volumio[972]: error: updateQueue error: null Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:07 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 55ms Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand add "INTERNAL/music_mp3/music/昨日重现.mp3" took 51 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 7ms Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 7ms Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand play Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:07 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:07 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 12ms Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand play took 11 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 7ms Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 6ms Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 4 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: Aug 31 23:07:07 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 6 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand status took 2 milliseconds Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:07 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:07 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:07 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:07 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:07 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 28ms Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 41ms Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 41ms Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 32 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 32 milliseconds Aug 31 23:07:07 volumio volumio[972]: info: sendMpdCommand playlistinfo took 32 milliseconds Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:07 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:07 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:07 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:07 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:07 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:07 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:07 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:07 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 75ms Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 73ms Aug 31 23:07:07 volumio volumio[972]: info: ------------------------------ 73ms Aug 31 23:07:10 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:10 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::ClearQueue Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::stop Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::stPlaybackTimer Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::updateTrackBlock Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrackBlock Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::serviceStop Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::serviceStop Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::stop Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::clearPlayQueue Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::saveQueue Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushQueue Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::addQueueItems Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::addQueueItems Aug 31 23:07:16 volumio volumio[972]: info: Preload queue cleared Aug 31 23:07:16 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/music/卡萨布兰卡.mp3 Aug 31 23:07:16 volumio volumio[972]: info: Exploding uri music-library/INTERNAL/music_mp3/music/卡萨布兰卡.mp3 in service mpd Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand stop took 16 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: ALBUMART /albumart?cacheid=642&web=/%E4%B9%A1%E6%9D%91%E4%B9%8B%E6%AD%8C%20Disc%201/medium&path=%2Fmnt%2FINTERNAL%2Fmusic_mp3%2Fmusic%2F%E5%8D%A1%E8%90%A8%E5%B8%83%E5%85%B0%E5%8D%A1.mp3&metadata=false Aug 31 23:07:16 volumio volumio[972]: info: URI /mnt/INTERNAL/music_mp3/music/卡萨布兰卡.mp3 Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 4 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushQueue Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::saveQueue Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::updateTrackBlock Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrackBlock Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPlay Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::play index 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::stop Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::play index undefined Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::startPlaybackTimer Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/music/卡萨布兰卡.mp3 Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 12 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand stop took 2 milliseconds Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: No code Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: No code Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 51ms Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 51ms Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:16 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 47 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand clear took 46 milliseconds Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/music/卡萨布兰卡.mp3" Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: No code Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 79ms Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:16 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:16 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:16 volumio volumio[972]: error: updateQueue error: null Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:16 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 25ms Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand add "INTERNAL/music_mp3/music/卡萨布兰卡.mp3" took 23 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 4ms Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 4ms Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand play Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:16 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:16 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 17ms Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand play took 16 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 12ms Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 11ms Aug 31 23:07:16 volumio volumio[972]: info: Listing playlists Aug 31 23:07:16 volumio volumio[972]: info: Listing playlists Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 4 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: Aug 31 23:07:16 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 14 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 13 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 4 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand status took 4 milliseconds Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"卡萨布兰卡.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/卡萨布兰卡.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"卡萨布兰卡.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/卡萨布兰卡.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:16 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 32ms Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 37ms Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 20 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 19 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 20 milliseconds Aug 31 23:07:16 volumio volumio[972]: info: sendMpdCommand playlistinfo took 19 milliseconds Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"卡萨布兰卡.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/卡萨布兰卡.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:16 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"卡萨布兰卡.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/卡萨布兰卡.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:16 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"卡萨布兰卡.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/卡萨布兰卡.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:16 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"卡萨布兰卡.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/卡萨布兰卡.mp3","trackType":"mp3"} Aug 31 23:07:16 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:16 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:16 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:16 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 92ms Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 91ms Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 81ms Aug 31 23:07:16 volumio volumio[972]: info: ------------------------------ 80ms Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::ClearQueue Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::stop Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::stPlaybackTimer Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::updateTrackBlock Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrackBlock Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::serviceStop Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::serviceStop Aug 31 23:07:18 volumio volumio[972]: info: ControllerMpd::stop Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::clearPlayQueue Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::saveQueue Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioPushQueue Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::addQueueItems Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::addQueueItems Aug 31 23:07:18 volumio volumio[972]: info: Preload queue cleared Aug 31 23:07:18 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/music/昨日重现.mp3 Aug 31 23:07:18 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/music/昨日重现.mp3 Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioPushQueue Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::saveQueue Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::updateTrackBlock Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrackBlock Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioPlay Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::play index 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::stop Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::play index undefined Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::startPlaybackTimer Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/music/昨日重现.mp3 Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 23:07:18 volumio volumio[972]: info: Aug 31 23:07:18 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:18 volumio volumio[972]: info: sendMpdCommand stop took 17 milliseconds Aug 31 23:07:18 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:18 volumio volumio[972]: info: sendMpdCommand stop took 4 milliseconds Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 23:07:18 volumio volumio[972]: info: Aug 31 23:07:18 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:18 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:18 volumio volumio[972]: info: Aug 31 23:07:18 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:18 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:18 volumio volumio[972]: info: Aug 31 23:07:18 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:18 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:18 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:18 volumio volumio[972]: info: sendMpdCommand clear took 3 milliseconds Aug 31 23:07:18 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/music/昨日重现.mp3" Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:18 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: 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} Aug 31 23:07:18 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:18 volumio volumio[972]: info: No code Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:18 volumio volumio[972]: info: ------------------------------ 24ms Aug 31 23:07:18 volumio volumio[972]: info: Aug 31 23:07:18 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:18 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:18 volumio volumio[972]: info: Aug 31 23:07:18 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:18 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:18 volumio volumio[972]: error: updateQueue error: null Aug 31 23:07:18 volumio volumio[972]: info: Aug 31 23:07:18 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:18 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:18 volumio volumio[972]: info: sendMpdCommand status took 28 milliseconds Aug 31 23:07:18 volumio volumio[972]: info: ------------------------------ 27ms Aug 31 23:07:18 volumio volumio[972]: info: sendMpdCommand playlistinfo took 26 milliseconds Aug 31 23:07:18 volumio volumio[972]: info: sendMpdCommand add "INTERNAL/music_mp3/music/昨日重现.mp3" took 26 milliseconds Aug 31 23:07:18 volumio volumio[972]: info: ------------------------------ 4ms Aug 31 23:07:18 volumio volumio[972]: info: ------------------------------ 5ms Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:18 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand play Aug 31 23:07:18 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:18 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:18 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:18 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: 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} Aug 31 23:07:19 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: info: No code Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 54ms Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 57ms Aug 31 23:07:19 volumio volumio[972]: info: Aug 31 23:07:19 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:19 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:19 volumio volumio[972]: info: Aug 31 23:07:19 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:07:19 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: Aug 31 23:07:19 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:19 volumio volumio[972]: info: Aug 31 23:07:19 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 42ms Aug 31 23:07:19 volumio volumio[972]: info: sendMpdCommand play took 40 milliseconds Aug 31 23:07:19 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 15ms Aug 31 23:07:19 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 15ms Aug 31 23:07:19 volumio volumio[972]: info: Aug 31 23:07:19 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:19 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:19 volumio volumio[972]: info: Aug 31 23:07:19 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:19 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:19 volumio volumio[972]: info: sendMpdCommand status took 6 milliseconds Aug 31 23:07:19 volumio volumio[972]: info: sendMpdCommand status took 5 milliseconds Aug 31 23:07:19 volumio volumio[972]: info: sendMpdCommand status took 4 milliseconds Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:19 volumio volumio[972]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 31 23:07:19 volumio volumio[972]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 31 23:07:19 volumio volumio[972]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 31 23:07:19 volumio volumio[972]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:19 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:19 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:19 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:07:19 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:19 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:19 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:19 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:19 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:19 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:07:19 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:19 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:19 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 34ms Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 56ms Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 55ms Aug 31 23:07:19 volumio volumio[972]: info: ------------------------------ 54ms Aug 31 23:07:20 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:20 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:30 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:30 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio nmbd[901]: [2024/08/31 23:07:37.139650, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Aug 31 23:07:37 volumio nmbd[901]: query_name_response: Multiple (2) responses received for a query on subnet 10.62.0.25 for name WORKGROUP<1d>. Aug 31 23:07:37 volumio nmbd[901]: This response was from IP 10.62.0.251, reporting an IP address of 10.62.0.251. Aug 31 23:07:37 volumio volumio[972]: info: Aug 31 23:07:37 volumio volumio[972]: ---------------------------- Client requests Volumio pause Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::volumioPause Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::pause Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::stPlaybackTimer Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::servicePause Aug 31 23:07:37 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::servicePause Aug 31 23:07:37 volumio volumio[972]: info: ControllerMpd::pause Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand pause Aug 31 23:07:37 volumio volumio[972]: info: sendMpdCommand pause took 3 milliseconds Aug 31 23:07:37 volumio volumio[972]: info: Aug 31 23:07:37 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:37 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:37 volumio volumio[972]: info: Aug 31 23:07:37 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:37 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:37 volumio volumio[972]: info: Aug 31 23:07:37 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:07:37 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:07:37 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:37 volumio volumio[972]: info: sendMpdCommand status took 2 milliseconds Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:37 volumio volumio[972]: info: sendMpdCommand status took 3 milliseconds Aug 31 23:07:37 volumio volumio[972]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 31 23:07:37 volumio volumio[972]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:37 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:37 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio volumio[972]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":19613,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:37 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::syncState stateService pause Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus pause Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:37 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::stPlaybackTimer Aug 31 23:07:37 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:37 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio volumio[972]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":19613,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:37 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::syncState stateService pause Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus pause Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:37 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::stPlaybackTimer Aug 31 23:07:37 volumio volumio[972]: info: ------------------------------ 20ms Aug 31 23:07:37 volumio volumio[972]: info: ------------------------------ 19ms Aug 31 23:07:37 volumio volumio[972]: info: sendMpdCommand playlistinfo took 15 milliseconds Aug 31 23:07:37 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:07:37 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:07:37 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio volumio[972]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":19613,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"80 Kbps","isStreaming":false,"title":"昨日重现.mp3","artist":null,"album":"乡村之歌 Disc 1","uri":"INTERNAL/music_mp3/music/昨日重现.mp3","trackType":"mp3"} Aug 31 23:07:37 volumio volumio[972]: verbose: CURRENT POSITION 0 Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::syncState stateService pause Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus pause Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:07:37 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:07:37 volumio volumio[972]: info: CoreStateMachine::stPlaybackTimer Aug 31 23:07:37 volumio volumio[972]: info: ------------------------------ 30ms Aug 31 23:07:37 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:37 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:37 volumio volumio[972]: info: Listing playlists Aug 31 23:07:37 volumio volumio[972]: info: Listing playlists Aug 31 23:07:40 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:40 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:07:50 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:07:50 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:08:00 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:08:00 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:08:00 volumio volumio[972]: info: Listing playlists Aug 31 23:08:00 volumio volumio[972]: info: Listing playlists Aug 31 23:08:04 volumio volumio[972]: info: Preload queue cleared Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::ClearQueue Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::stop Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::updateTrackBlock Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrackBlock Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::stPlaybackTimer Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::serviceStop Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::serviceStop Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::stop Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::clearPlayQueue Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::saveQueue Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushQueue Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::addQueueItems Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::addQueueItems Aug 31 23:08:04 volumio volumio[972]: info: Preload queue cleared Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/2002年的第一场雪_刀郎.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/2002年的第一场雪_刀郎.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/一无所有_崔健.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/一无所有_崔健.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/伤心太平洋_任贤齐.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/伤心太平洋_任贤齐.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/最美_羽泉.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/最美_羽泉.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/又见炊烟_邓丽君.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/又见炊烟_邓丽君.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/吻别_张学友.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/吻别_张学友.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/大海_张雨生.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/大海_张雨生.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/天天想你_张雨生.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/天天想你_张雨生.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/当爱已成往事_张国荣.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/当爱已成往事_张国荣.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/我终于失去了你_赵传.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/我终于失去了你_赵传.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/把悲伤留给自己_陈升.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/把悲伤留给自己_陈升.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/无地自容_黑豹.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/无地自容_黑豹.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/是心非_张雨生.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/是心非_张雨生.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/月亮之上_凤凰传奇.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/月亮之上_凤凰传奇.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/有多少爱可以重来_迪克牛仔.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/有多少爱可以重来_迪克牛仔.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/梦醒时分国_陈淑桦.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/梦醒时分国_陈淑桦.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Adding Item to queue: music-library/INTERNAL/music_mp3/国语/沧海一声笑_任贤齐.mp3 Aug 31 23:08:04 volumio volumio[972]: info: Using cached record of: music-library/INTERNAL/music_mp3/国语/沧海一声笑_任贤齐.mp3 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushQueue Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::saveQueue Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::updateTrackBlock Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrackBlock Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPlay Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::play index 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::stop Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::play index undefined Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::startPlaybackTimer Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3 Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand stop took 37 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand stop took 11 milliseconds Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:08:04 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand status took 5 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand clear took 4 milliseconds Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3" Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:08:04 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:08:04 volumio volumio[972]: error: updateQueue error: null Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:08:04 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand status took 8 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 7ms Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand add "INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3" took 6 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 6ms Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand play Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: 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} Aug 31 23:08:04 volumio volumio[972]: verbose: CURRENT POSITION 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: No code Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: 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} Aug 31 23:08:04 volumio volumio[972]: verbose: CURRENT POSITION 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: No code Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 59ms Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 59ms Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 63ms Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:08:04 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:08:04 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 55ms Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand play took 53 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 4ms Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 3ms Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces system playlist update Aug 31 23:08:04 volumio volumio[972]: info: Ignoring MPD Status Update Aug 31 23:08:04 volumio volumio[972]: info: Aug 31 23:08:04 volumio volumio[972]: ---------------------------- MPD announces state update: player Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::getState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand status took 15 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand status took 16 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand status took 14 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 14ms Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand status took 13 milliseconds Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseState Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 31 23:08:04 volumio volumio[972]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:08:04 volumio volumio[972]: verbose: ControllerMpd::parseTrackInfo Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"沉默是金张国荣、许冠杰_张国荣.mp3","artist":null,"album":null,"uri":"INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3","trackType":"mp3"} Aug 31 23:08:04 volumio volumio[972]: verbose: CURRENT POSITION 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"沉默是金张国荣、许冠杰_张国荣.mp3","artist":null,"album":null,"uri":"INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3","trackType":"mp3"} Aug 31 23:08:04 volumio volumio[972]: verbose: CURRENT POSITION 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:08:04 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"沉默是金张国荣、许冠杰_张国荣.mp3","artist":null,"album":null,"uri":"INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3","trackType":"mp3"} Aug 31 23:08:04 volumio volumio[972]: verbose: CURRENT POSITION 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:08:04 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: ControllerMpd::pushState Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"沉默是金张国荣、许冠杰_张国荣.mp3","artist":null,"album":null,"uri":"INTERNAL/music_mp3/国语/沉默是金张国荣、许冠杰_张国荣.mp3","trackType":"mp3"} Aug 31 23:08:04 volumio volumio[972]: verbose: CURRENT POSITION 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService play Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus play Aug 31 23:08:04 volumio volumio[972]: info: Received an update from plugin. extracting info from payload Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: CoreStateMachine::pushState Aug 31 23:08:04 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Aug 31 23:08:04 volumio volumio[972]: info: ------------------------------ 47ms Aug 31 23:08:05 volumio volumio[972]: info: ------------------------------ 70ms Aug 31 23:08:05 volumio volumio[972]: info: ------------------------------ 69ms Aug 31 23:08:05 volumio volumio[972]: info: ------------------------------ 67ms Aug 31 23:08:06 volumio sudo[2547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 23:08:06 volumio sudo[2547]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 23:08:06 volumio sudo[2547]: pam_unix(sudo:session): session closed for user root Aug 31 23:08:06 volumio sudo[2550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 23:08:06 volumio sudo[2550]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 23:08:06 volumio sudo[2550]: pam_unix(sudo:session): session closed for user root Aug 31 23:08:06 volumio volumio[972]: verbose: New Socket.io Connection to 10.62.0.25 from 10.62.0.50 UA: Mozilla/5.0 (Linux; Android 13; V2072A Build/TP1A.220624.014) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/101.0.4951.74 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:08:07 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::volumioGetQueue Aug 31 23:08:07 volumio volumio[972]: info: CoreStateMachine::getQueue Aug 31 23:08:07 volumio volumio[972]: info: CorePlayQueue::getQueue Aug 31 23:08:07 volumio volumio[972]: info: Listing playlists Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 23:08:07 volumio volumio[972]: info: Received Get System Info Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 23:08:07 volumio volumio[972]: info: Discovery: Getting this device information Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:08:07 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:08:07 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 23:08:07 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 31 23:08:08 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 23:08:08 volumio volumio[972]: info: Received Get System Info Aug 31 23:08:08 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 23:08:08 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 23:08:08 volumio volumio[972]: info: Discovery: Getting this device information Aug 31 23:08:08 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:08:08 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:08 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 23:08:08 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 31 23:08:10 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Aug 31 23:08:10 volumio volumio[972]: info: CorePlayQueue::getTrack 16 Aug 31 23:08:16 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 31 23:08:17 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 23:08:17 volumio volumio[972]: info: CURURI: music-library/INTERNAL/music_mp3/怀旧金曲 Aug 31 23:08:17 volumio volumio[972]: info: Preload queue cleared Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/Colours_of_The_World世界杯歌曲李纹演唱.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/DI DA DI.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/hotel california_eagles.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/一天到晚游泳的鱼.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/不散的筵席.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/为爱犯了罪.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/人生何处不相逢--陈慧娴.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/人生何处不相逢.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/今生今世.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/你爱我那么多.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/最浪漫的事.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/冷雨夜.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/别走.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/十个救火的少年.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/原来你什么都不要.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/双鱼座.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/听海.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/囚鸟.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/回心转意.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/如果没有你在身边的时候.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/孤单背影_陈慧娴.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/孤寂.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/干杯!朋友.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/恋曲1990.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/悬崖.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/感情不是一盏灯.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/我可以抱你吗？.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/梁祝.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/梦醒时分.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/沉默是金.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/浪人情歌.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/涟漪.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/爱不爱我.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/痴情意外_陈慧娴.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/相信自己.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/相思风雨中.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/知心爱人.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/石头记.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/第一眼的爱情.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/老鹰之歌.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/范晓萱-雪人.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/让生命等候.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/说谎.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/那天.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/野百合也有春天.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/陈慧娴_飘雪.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/雪人.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/顺其自然.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/高胜美_哭砂.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/老鹰合唱团-魅力女人.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/对不起.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/I Believe.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/梁静茹-爱你不是两三天.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/千千阙歌.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/红茶馆.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/飘雪.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/没有烟总有花.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/太委屈.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/分裂.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/比我幸福.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/看过你流泪.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/周启生-天长地久.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/第四晚心情.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/七分爱情三分骗.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/玻璃窗的爱.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/爱太难.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/爱是个坏东西.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/寂寞有害.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/我知道我不够漂亮.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/解脱.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/快乐无罪.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/梦一场.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/黄凯芹_伤感的恋人.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/心有独钟(陈晓东).mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/丝路.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/天黑黑.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/万水千山总是情.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/回家.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/IBeliev[1].mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/体会.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/傻女.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/过完冬季.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/只有分离.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/I love you so much.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/姐妹们站起来.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/万人迷.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/你还爱我吗.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/天花乱坠.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/马路天使.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/我要的幸福.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/i believe(korea).mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/反方向的钟.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/斗牛.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/懂事.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/天鹅man.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/温暖.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/明天去爱谁.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/勇气.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/刀马旦.mp3 Aug 31 23:08:17 volumio volumio[972]: info: Preloading song: music-library/INTERNAL/music_mp3/怀旧金曲/动心.mp3 Aug 31 23:08:17 volumio volumio[972]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 23:08:17 volumio volumio[972]: Error: connect ETIMEDOUT 162.125.6.1:80 Aug 31 23:08:17 volumio volumio[972]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Aug 31 23:08:17 volumio volumio[972]: errno: -110, Aug 31 23:08:17 volumio volumio[972]: code: 'ETIMEDOUT', Aug 31 23:08:17 volumio volumio[972]: syscall: 'connect', Aug 31 23:08:17 volumio volumio[972]: address: '162.125.6.1', Aug 31 23:08:17 volumio volumio[972]: port: 80 Aug 31 23:08:17 volumio volumio[972]: } Aug 31 23:08:17 volumio volumio[972]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 23:08:17 volumio sudo[2595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-31 23:07 Aug 31 23:08:17 volumio sudo[2595]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"