-- Logs begin at Mon 2024-04-22 02:35:15 UTC, end at Mon 2024-04-22 03:38:11 UTC. -- Apr 22 03:37:02 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:06 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:10 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPlay Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::play index undefined Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::startPlaybackTimer Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::clearAddPlayTracks NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand stop took 5 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand clear took 2 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand add "NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac" Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand add "NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac" took 9 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 20ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 18ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand play took 12 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 12ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 9ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 5ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 9ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand status took 273 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand status took 278 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand status took 275 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Apr 22 03:37:12 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 15 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand status took 13 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand status took 8 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"963 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus stop Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":156,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1244 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":502,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1314 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 341ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 373ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ------------------------------ 372ms Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand status took 89 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 79 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 77 milliseconds Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1314 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1314 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:12 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:12 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:12 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:13 volumio.hoting volumio[9632]: info: ------------------------------ 155ms Apr 22 03:37:13 volumio.hoting volumio[9632]: info: ------------------------------ 148ms Apr 22 03:37:13 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 134 milliseconds Apr 22 03:37:13 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:13 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:13 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1314 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:13 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:13 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:13 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:13 volumio.hoting volumio[9632]: info: ------------------------------ 262ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Preload queue cleared Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::ClearQueue Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::stPlaybackTimer Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::updateTrackBlock Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrackBlock Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::serviceStop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::serviceStop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::stop Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::clearPlayQueue Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::saveQueue Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushQueue Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::addQueueItems Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::addQueueItems Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Preload queue cleared Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Adding Item to queue: albums://%E8%8C%83%E6%9C%AC%E6%A1%90/2022%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%20%E7%AC%AC5%E6%9C%9F%20 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Exploding uri albums://%E8%8C%83%E6%9C%AC%E6%A1%90/2022%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%20%E7%AC%AC5%E6%9C%9F%20 in service mpd Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushQueue Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::saveQueue Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::updateTrackBlock Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrackBlock Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPlay Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::play index 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::play index undefined Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::startPlaybackTimer Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::clearAddPlayTracks NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand stop took 161 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand stop took 118 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand clear Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 8 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand clear took 8 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 6 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand add "NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac" Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: 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} Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: No code Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 71ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:14 volumio.hoting volumio[9632]: error: updateQueue error: null Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 72 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 72ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 68 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand add "NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac" took 68 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 6ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 5ms Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: 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} Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: No code Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 123ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 129ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces system playlist update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Ignoring MPD Status Update Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 77ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand play took 72 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 27ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 26ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 92 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 92 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 91 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 3 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"965 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus stop Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 101ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Apr 22 03:37:14 volumio.hoting volumio[9632]: ---------------------------- MPD announces state update: player Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::getState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand status Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 4 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand status took 3 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseState Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1244 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":920,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1244 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1314 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 189ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 189ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 101ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 87 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: info: sendMpdCommand playlistinfo took 86 milliseconds Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: ControllerMpd::parseTrackInfo Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1314 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ControllerMpd::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::servicePushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":223,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1314 Kbps","isStreaming":false,"title":"情歌 (Live)","artist":"范本桐","album":"2022中国好声音 第5期 ","uri":"NAS/Hoting/音乐/02.FLAC格式歌曲/【04】深夜伤感歌曲【FLAC格式】/范本桐 - 情歌 (Live).flac","trackType":"flac"} Apr 22 03:37:14 volumio.hoting volumio[9632]: verbose: CURRENT POSITION 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState stateService play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::syncState currentStatus play Apr 22 03:37:14 volumio.hoting volumio[9632]: info: Received an update from plugin. extracting info from payload Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 144ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: ------------------------------ 142ms Apr 22 03:37:14 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:18 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:22 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:24 volumio.hoting kernel: ieee80211 phy0: sched_scan start : n_ssids=2 n_match_sets=2 Apr 22 03:37:24 volumio.hoting kernel: ieee80211 phy0: n_channels=29 interval=10 ie_len=126 Apr 22 03:37:26 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:30 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:34 volumio.hoting volumio[9632]: info: VolumeController::SetAlsaVolume31 Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:34 volumio.hoting volumio[9632]: info: VolumeController::SetAlsaVolume19 Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CoreStateMachine::pushState Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CorePlayQueue::getTrack 0 Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 03:37:34 volumio.hoting volumio[9632]: info: CoreCommandRouter::volumioPushState Apr 22 03:37:38 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:42 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:46 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:50 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:54 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:37:58 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:38:02 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:38:06 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:38:10 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 22 03:38:10 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 22 03:38:10 volumio.hoting volumio-remote-updater[584]: No test mode Apr 22 03:38:10 volumio.hoting volumio-remote-updater[584]: No alpha test mode Apr 22 03:38:10 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 22 03:38:10 volumio.hoting volumio[9632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 22 03:38:11 volumio.hoting volumio[9632]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 03:38:11 volumio.hoting volumio[9632]: Error: connect ETIMEDOUT 69.171.224.36:80 Apr 22 03:38:11 volumio.hoting volumio[9632]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 22 03:38:11 volumio.hoting volumio[9632]: errno: -110, Apr 22 03:38:11 volumio.hoting volumio[9632]: code: 'ETIMEDOUT', Apr 22 03:38:11 volumio.hoting volumio[9632]: syscall: 'connect', Apr 22 03:38:11 volumio.hoting volumio[9632]: address: '69.171.224.36', Apr 22 03:38:11 volumio.hoting volumio[9632]: port: 80 Apr 22 03:38:11 volumio.hoting volumio[9632]: } Apr 22 03:38:11 volumio.hoting volumio[9632]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 03:38:11 volumio.hoting sudo[9935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-22 03:37 Apr 22 03:38:11 volumio.hoting sudo[9935]: 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"