Oct 13 18:25:00 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:25:02 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 18:25:02 volumio volumio[1337]: info: CURURI: music-library/NAS/Music/Sound Track Oct 13 18:25:04 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:25:08 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 18:25:08 volumio volumio[1337]: info: CURURI: music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』 Oct 13 18:25:08 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:25:09 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 18:25:09 volumio volumio[1337]: info: CURURI: music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1 Oct 13 18:25:09 volumio volumio[1337]: error: Cue Parser - Cannot parse NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.cue Oct 13 18:25:10 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:25:10 volumio volumio[1337]: info: Preloading song: music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav Oct 13 18:25:10 volumio volumio[1337]: info: Exploding uri music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav in service mpd Oct 13 18:25:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=43&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2FSound%20Track%2F%E3%80%8E%E5%8F%B2%E4%B8%8A%E6%9C%80%E4%BC%98%E7%BE%8Ede%E8%83%8C%E6%99%AF%E9%9F%B3%E4%B9%90%E3%80%8F%2FDISC%201%2F%E5%8F%B2%E4%B8%8A%E6%9C%80%E4%BC%98%E7%BE%8Ede%E8%83%8C%E6%99%AF%E9%9F%B3%E4%B9%90%20CD1.wav&metadata=false Oct 13 18:25:10 volumio volumio[1337]: info: URI /mnt/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav Oct 13 18:25:11 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:25:11 volumio volumio[1337]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::ClearQueue Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::stop Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:25:11 volumio volumio[1337]: info: CorePlayQueue::clearPlayQueue Oct 13 18:25:11 volumio volumio[1337]: info: CorePlayQueue::saveQueue Oct 13 18:25:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPushQueue Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::addQueueItems Oct 13 18:25:11 volumio volumio[1337]: info: CorePlayQueue::addQueueItems Oct 13 18:25:11 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:25:11 volumio volumio[1337]: info: Adding Item to queue: music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav Oct 13 18:25:11 volumio volumio[1337]: info: Using cached record of: music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav Oct 13 18:25:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPushQueue Oct 13 18:25:11 volumio volumio[1337]: info: CorePlayQueue::saveQueue Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::updateTrackBlock Oct 13 18:25:11 volumio volumio[1337]: info: CorePlayQueue::getTrackBlock Oct 13 18:25:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPlay Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::play index 0 Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::stop Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::play index undefined Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:25:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:11 volumio volumio[1337]: info: CoreStateMachine::startPlaybackTimer Oct 13 18:25:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:11 volumio volumio[1337]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav Oct 13 18:25:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:25:11 volumio volumio[1337]: info: sendMpdCommand stop took 35 milliseconds Oct 13 18:25:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand clear Oct 13 18:25:11 volumio volumio[1337]: info: Oct 13 18:25:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:25:11 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:25:11 volumio volumio[1337]: info: sendMpdCommand clear took 68 milliseconds Oct 13 18:25:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav" Oct 13 18:25:11 volumio volumio[1337]: info: Oct 13 18:25:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:25:11 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:25:11 volumio volumio[1337]: info: Oct 13 18:25:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:25:11 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:25:11 volumio volumio[1337]: error: updateQueue error: null Oct 13 18:25:11 volumio volumio[1337]: info: Oct 13 18:25:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:25:11 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:25:11 volumio volumio[1337]: info: ------------------------------ 6ms Oct 13 18:25:11 volumio volumio[1337]: info: sendMpdCommand add "NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav" took 4 milliseconds Oct 13 18:25:11 volumio volumio[1337]: info: ------------------------------ 5ms Oct 13 18:25:11 volumio volumio[1337]: info: ------------------------------ 4ms Oct 13 18:25:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand play Oct 13 18:25:11 volumio volumio[1337]: info: Oct 13 18:25:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:25:11 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:25:11 volumio volumio[1337]: info: Oct 13 18:25:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:25:11 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:25:11 volumio volumio[1337]: info: ------------------------------ 68ms Oct 13 18:25:11 volumio volumio[1337]: info: sendMpdCommand play took 66 milliseconds Oct 13 18:25:11 volumio volumio[1337]: info: ------------------------------ 34ms Oct 13 18:25:11 volumio volumio[1337]: info: ------------------------------ 33ms Oct 13 18:25:14 volumio volumio[1337]: info: Oct 13 18:25:14 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:14 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:14 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:14 volumio volumio[1337]: info: Oct 13 18:25:14 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:14 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:14 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:14 volumio volumio[1337]: info: Oct 13 18:25:14 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:14 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:14 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:14 volumio volumio[1337]: info: Oct 13 18:25:14 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand status took 53 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand status took 53 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand status took 52 milliseconds Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:15 volumio volumio[1337]: info: Oct 13 18:25:15 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:15 volumio volumio[1337]: info: Oct 13 18:25:15 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand status took 152 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 151 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 88 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 89 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand status took 87 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand status took 20 milliseconds Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:15 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:15 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:15 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:15 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:15 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: ------------------------------ 408ms Oct 13 18:25:15 volumio volumio[1337]: info: ------------------------------ 488ms Oct 13 18:25:15 volumio volumio[1337]: info: ------------------------------ 494ms Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 289 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 180 milliseconds Oct 13 18:25:15 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 198 milliseconds Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:15 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:15 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:15 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:15 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:15 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:15 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:15 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:15 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:15 volumio volumio[1337]: info: ------------------------------ 619ms Oct 13 18:25:15 volumio volumio[1337]: info: ------------------------------ 566ms Oct 13 18:25:15 volumio volumio[1337]: info: ------------------------------ 565ms Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::volumioSeek Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::seek Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: TRACKBLOCK {"uri":"mnt/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","service":"mpd","name":"史上最优美de背景音乐 CD1.wav","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=43&web=//extralarge&path=%2FNAS%2FMusic%2FSound%20Track%2F%E3%80%8E%E5%8F%B2%E4%B8%8A%E6%9C%80%E4%BC%98%E7%BE%8Ede%E8%83%8C%E6%99%AF%E9%9F%B3%E4%B9%90%E3%80%8F%2FDISC%201&metadata=false","duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"wav","channels":2} Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::startPlaybackTimer Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: ControllerMpd::seek Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:27 volumio volumio[1337]: error: null Oct 13 18:25:27 volumio volumio[1337]: info: Oct 13 18:25:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:27 volumio volumio[1337]: info: Oct 13 18:25:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:27 volumio volumio[1337]: info: Oct 13 18:25:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:27 volumio volumio[1337]: info: sendMpdCommand status took 48 milliseconds Oct 13 18:25:27 volumio volumio[1337]: info: sendMpdCommand status took 47 milliseconds Oct 13 18:25:27 volumio volumio[1337]: info: sendMpdCommand status took 5 milliseconds Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 69 milliseconds Oct 13 18:25:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 69 milliseconds Oct 13 18:25:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 68 milliseconds Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2707871,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:27 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2707871,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:27 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2707871,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:27 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:27 volumio volumio[1337]: info: ------------------------------ 412ms Oct 13 18:25:27 volumio volumio[1337]: info: ------------------------------ 412ms Oct 13 18:25:27 volumio volumio[1337]: info: ------------------------------ 420ms Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::volumioSeek Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::seek Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: TRACKBLOCK {"uri":"mnt/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","service":"mpd","name":"史上最优美de背景音乐 CD1.wav","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=43&web=//extralarge&path=%2FNAS%2FMusic%2FSound%20Track%2F%E3%80%8E%E5%8F%B2%E4%B8%8A%E6%9C%80%E4%BC%98%E7%BE%8Ede%E8%83%8C%E6%99%AF%E9%9F%B3%E4%B9%90%E3%80%8F%2FDISC%201&metadata=false","duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"wav","channels":2} Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::startPlaybackTimer Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: ControllerMpd::seek Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:30 volumio volumio[1337]: error: null Oct 13 18:25:30 volumio volumio[1337]: info: Oct 13 18:25:30 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:30 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:30 volumio volumio[1337]: info: Oct 13 18:25:30 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:30 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:30 volumio volumio[1337]: info: Oct 13 18:25:30 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:30 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:30 volumio volumio[1337]: info: sendMpdCommand status took 41 milliseconds Oct 13 18:25:30 volumio volumio[1337]: info: sendMpdCommand status took 4 milliseconds Oct 13 18:25:30 volumio volumio[1337]: info: sendMpdCommand status took 3 milliseconds Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:30 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 13 18:25:30 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 13 18:25:30 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:30 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:30 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2117000,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:30 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:30 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:30 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2117871,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:30 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:30 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:30 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2117871,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:30 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:30 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:30 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:30 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:30 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:30 volumio volumio[1337]: info: ------------------------------ 367ms Oct 13 18:25:30 volumio volumio[1337]: info: ------------------------------ 367ms Oct 13 18:25:30 volumio volumio[1337]: info: ------------------------------ 361ms Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::volumioSeek Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::seek Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: TRACKBLOCK {"uri":"mnt/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","service":"mpd","name":"史上最优美de背景音乐 CD1.wav","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=43&web=//extralarge&path=%2FNAS%2FMusic%2FSound%20Track%2F%E3%80%8E%E5%8F%B2%E4%B8%8A%E6%9C%80%E4%BC%98%E7%BE%8Ede%E8%83%8C%E6%99%AF%E9%9F%B3%E4%B9%90%E3%80%8F%2FDISC%201&metadata=false","duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"wav","channels":2} Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::startPlaybackTimer Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: ControllerMpd::seek Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:37 volumio volumio[1337]: error: null Oct 13 18:25:37 volumio volumio[1337]: info: Oct 13 18:25:37 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:37 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:37 volumio volumio[1337]: info: Oct 13 18:25:37 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:37 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:37 volumio volumio[1337]: info: Oct 13 18:25:37 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:25:37 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:25:37 volumio volumio[1337]: info: sendMpdCommand status took 11 milliseconds Oct 13 18:25:37 volumio volumio[1337]: info: sendMpdCommand status took 11 milliseconds Oct 13 18:25:37 volumio volumio[1337]: info: sendMpdCommand status took 10 milliseconds Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:25:37 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 82 milliseconds Oct 13 18:25:37 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 81 milliseconds Oct 13 18:25:37 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 81 milliseconds Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:37 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:25:37 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1214000,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:37 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:37 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:37 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1214000,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:37 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:37 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:37 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1214000,"duration":3169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"史上最优美de背景音乐 CD1.wav","artist":null,"album":null,"uri":"NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 1/史上最优美de背景音乐 CD1.wav","trackType":"wav"} Oct 13 18:25:37 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:25:37 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:37 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:37 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:37 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:37 volumio volumio[1337]: info: ------------------------------ 576ms Oct 13 18:25:37 volumio volumio[1337]: info: ------------------------------ 616ms Oct 13 18:25:37 volumio volumio[1337]: info: ------------------------------ 616ms Oct 13 18:25:40 volumio volumio[1337]: info: VolumeController::SetAlsaVolume75 Oct 13 18:25:40 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:40 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:40 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:40 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:41 volumio volumio[1337]: info: VolumeController::SetAlsaVolume21 Oct 13 18:25:41 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:41 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:41 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:41 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:46 volumio volumio[1337]: info: VolumeController::SetAlsaVolume97 Oct 13 18:25:46 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:46 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:46 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:46 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:46 volumio volumio[1337]: info: VolumeController::SetAlsaVolume100 Oct 13 18:25:46 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:46 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:46 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:46 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:52 volumio volumio[1337]: info: VolumeController::SetAlsaVolume83 Oct 13 18:25:52 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:52 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:52 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:52 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:53 volumio volumio[1337]: info: VolumeController::SetAlsaVolume74 Oct 13 18:25:53 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:53 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:53 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:53 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:54 volumio volumio[1337]: info: VolumeController::SetAlsaVolume44 Oct 13 18:25:54 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:54 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:54 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:54 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:55 volumio volumio[1337]: info: VolumeController::SetAlsaVolume28 Oct 13 18:25:55 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:55 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:55 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:55 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:58 volumio volumio[1337]: info: VolumeController::SetAlsaVolume98 Oct 13 18:25:58 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:58 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:58 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:58 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:25:58 volumio volumio[1337]: info: VolumeController::SetAlsaVolume0 Oct 13 18:25:58 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:25:58 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:25:58 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:25:58 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:00 volumio volumio[1337]: info: VolumeController::SetAlsaVolume100 Oct 13 18:26:00 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:00 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:00 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:26:00 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:11 volumio ntpd[1031]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 18:26:11 volumio ntpd[1031]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Oct 13 18:26:11 volumio ntpd[1031]: DNS: Pool skipping: 198.18.2.10 Oct 13 18:26:11 volumio ntpd[1031]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Oct 13 18:26:12 volumio ntpd[1031]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 18:26:12 volumio ntpd[1031]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Oct 13 18:26:12 volumio ntpd[1031]: DNS: Pool skipping: 198.18.2.11 Oct 13 18:26:12 volumio ntpd[1031]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Oct 13 18:26:13 volumio ntpd[1031]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 18:26:13 volumio ntpd[1031]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Oct 13 18:26:13 volumio ntpd[1031]: DNS: Pool skipping: 198.18.2.12 Oct 13 18:26:13 volumio ntpd[1031]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Oct 13 18:26:14 volumio ntpd[1031]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 18:26:14 volumio ntpd[1031]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Oct 13 18:26:14 volumio ntpd[1031]: DNS: Pool skipping: 198.18.2.13 Oct 13 18:26:14 volumio ntpd[1031]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Oct 13 18:26:16 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 18:26:16 volumio volumio[1337]: info: CURURI: music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 2 Oct 13 18:26:16 volumio volumio[1337]: error: Cue Parser - Cannot parse NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 2/史上最优美de背景音乐 CD2.cue Oct 13 18:26:17 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:26:17 volumio volumio[1337]: info: Preloading song: music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 2/史上最优美de背景音乐 CD2.wav Oct 13 18:26:17 volumio volumio[1337]: info: Exploding uri music-library/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 2/史上最优美de背景音乐 CD2.wav in service mpd Oct 13 18:26:17 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=43&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2FSound%20Track%2F%E3%80%8E%E5%8F%B2%E4%B8%8A%E6%9C%80%E4%BC%98%E7%BE%8Ede%E8%83%8C%E6%99%AF%E9%9F%B3%E4%B9%90%E3%80%8F%2FDISC%202%2F%E5%8F%B2%E4%B8%8A%E6%9C%80%E4%BC%98%E7%BE%8Ede%E8%83%8C%E6%99%AF%E9%9F%B3%E4%B9%90%20CD2.wav&metadata=false Oct 13 18:26:17 volumio volumio[1337]: info: URI /mnt/NAS/Music/Sound Track/『史上最优美de背景音乐』/DISC 2/史上最优美de背景音乐 CD2.wav Oct 13 18:26:23 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 13 18:26:23 volumio volumio[1337]: info: CURURI: music-library/NAS/Music/Sound Track/Matsuzawa Yumi Oct 13 18:26:23 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:26:23 volumio volumio[1337]: info: Preloading song: music-library/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3 Oct 13 18:26:23 volumio volumio[1337]: info: Preloading song: music-library/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Ending_kimi_to_onaji_aozora.mp3 Oct 13 18:26:23 volumio volumio[1337]: info: Exploding uri music-library/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3 in service mpd Oct 13 18:26:23 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=43&web=Matsuzawa%20Yumi/Chikyuugi/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FSound%20Track%2FMatsuzawa%20Yumi%2FHades_Opening_chikyuugi.mp3&metadata=false Oct 13 18:26:23 volumio volumio[1337]: info: URI /mnt/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3 Oct 13 18:26:23 volumio volumio[1337]: info: Exploding uri music-library/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Ending_kimi_to_onaji_aozora.mp3 in service mpd Oct 13 18:26:23 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=43&web=Matsuzawa%20Yumi/Chikyuugi/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FSound%20Track%2FMatsuzawa%20Yumi%2FHades_Ending_kimi_to_onaji_aozora.mp3&metadata=false Oct 13 18:26:23 volumio volumio[1337]: info: URI /mnt/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Ending_kimi_to_onaji_aozora.mp3 Oct 13 18:26:26 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::ClearQueue Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::stop Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::stPlaybackTimer Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::updateTrackBlock Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrackBlock Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::serviceStop Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::serviceStop Oct 13 18:26:26 volumio volumio[1337]: info: ControllerMpd::stop Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::clearPlayQueue Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::saveQueue Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushQueue Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::addQueueItems Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::addQueueItems Oct 13 18:26:26 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:26:26 volumio volumio[1337]: info: Adding Item to queue: music-library/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3 Oct 13 18:26:26 volumio volumio[1337]: info: Using cached record of: music-library/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushQueue Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::saveQueue Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::updateTrackBlock Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrackBlock Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPlay Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::play index 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::addQueueItems Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::addQueueItems Oct 13 18:26:26 volumio volumio[1337]: info: Preload queue cleared Oct 13 18:26:26 volumio volumio[1337]: info: Adding Item to queue: music-library/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Ending_kimi_to_onaji_aozora.mp3 Oct 13 18:26:26 volumio volumio[1337]: info: Using cached record of: music-library/NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Ending_kimi_to_onaji_aozora.mp3 Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::stop Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushQueue Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::saveQueue Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::play index undefined Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::updateTrackBlock Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrackBlock Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::startPlaybackTimer Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3 Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:26 volumio volumio[1337]: info: sendMpdCommand stop took 25 milliseconds Oct 13 18:26:26 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:26 volumio volumio[1337]: info: sendMpdCommand stop took 8 milliseconds Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand clear Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:26 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:26 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:26:26 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:26:26 volumio volumio[1337]: info: sendMpdCommand status took 5 milliseconds Oct 13 18:26:26 volumio volumio[1337]: info: sendMpdCommand clear took 4 milliseconds Oct 13 18:26:26 volumio volumio[1337]: info: sendMpdCommand status took 3 milliseconds Oct 13 18:26:26 volumio volumio[1337]: info: sendMpdCommand status took 2 milliseconds Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3" Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:26 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 13 18:26:26 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::syncState stateService stop Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:26 volumio volumio[1337]: info: No code Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:26 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 13 18:26:26 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::syncState stateService stop Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:26 volumio volumio[1337]: info: No code Oct 13 18:26:26 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:26 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:26 volumio volumio[1337]: info: ------------------------------ 39ms Oct 13 18:26:26 volumio volumio[1337]: info: ------------------------------ 39ms Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:26:26 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:26:26 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:26:26 volumio volumio[1337]: error: updateQueue error: null Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:26:26 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:26:26 volumio volumio[1337]: info: ------------------------------ 43ms Oct 13 18:26:26 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 42 milliseconds Oct 13 18:26:26 volumio volumio[1337]: info: sendMpdCommand add "NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3" took 42 milliseconds Oct 13 18:26:26 volumio volumio[1337]: info: ------------------------------ 4ms Oct 13 18:26:26 volumio volumio[1337]: info: ------------------------------ 3ms Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:26:26 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand play Oct 13 18:26:26 volumio volumio[1337]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 13 18:26:26 volumio volumio[1337]: info: ------------------------------ 51ms Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:26:26 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:26:26 volumio volumio[1337]: info: Oct 13 18:26:26 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Oct 13 18:26:26 volumio volumio[1337]: info: Ignoring MPD Status Update Oct 13 18:26:27 volumio volumio[1337]: info: Oct 13 18:26:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 87ms Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand play took 85 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 83ms Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 82ms Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:27 volumio volumio[1337]: info: Oct 13 18:26:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:27 volumio volumio[1337]: info: Oct 13 18:26:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:27 volumio volumio[1337]: info: Oct 13 18:26:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand status took 9 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand status took 8 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand status took 7 milliseconds Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:26:27 volumio volumio[1337]: info: Oct 13 18:26:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:27 volumio volumio[1337]: info: Oct 13 18:26:27 volumio volumio[1337]: ---------------------------- MPD announces state update: player Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::getState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand status took 6 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand status took 5 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand status took 4 milliseconds Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseState Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":246,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Chikyuugi","artist":"Matsuzawa Yumi","album":"Chikyuugi","uri":"NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3","trackType":"mp3"} Oct 13 18:26:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":246,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Chikyuugi","artist":"Matsuzawa Yumi","album":"Chikyuugi","uri":"NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3","trackType":"mp3"} Oct 13 18:26:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:26:27 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":246,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Chikyuugi","artist":"Matsuzawa Yumi","album":"Chikyuugi","uri":"NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3","trackType":"mp3"} Oct 13 18:26:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:26:27 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 32ms Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 46ms Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 47ms Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 33 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 32 milliseconds Oct 13 18:26:27 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 32 milliseconds Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:26:27 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":246,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Chikyuugi","artist":"Matsuzawa Yumi","album":"Chikyuugi","uri":"NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3","trackType":"mp3"} Oct 13 18:26:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:26:27 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":246,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Chikyuugi","artist":"Matsuzawa Yumi","album":"Chikyuugi","uri":"NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3","trackType":"mp3"} Oct 13 18:26:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:26:27 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: ControllerMpd::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":246,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Chikyuugi","artist":"Matsuzawa Yumi","album":"Chikyuugi","uri":"NAS/Music/Sound Track/Matsuzawa Yumi/Hades_Opening_chikyuugi.mp3","trackType":"mp3"} Oct 13 18:26:27 volumio volumio[1337]: verbose: CURRENT POSITION 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:26:27 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: CoreStateMachine::pushState Oct 13 18:26:27 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Oct 13 18:26:27 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 79ms Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 77ms Oct 13 18:26:27 volumio volumio[1337]: info: ------------------------------ 77ms Oct 13 18:26:36 volumio volumio[1337]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 18:26:36 volumio volumio[1337]: Error: Client network socket disconnected before secure TLS connection was established Oct 13 18:26:36 volumio volumio[1337]: at connResetException (node:internal/errors:720:14) Oct 13 18:26:36 volumio volumio[1337]: at TLSSocket.onConnectEnd (node:_tls_wrap:1682:19) Oct 13 18:26:36 volumio volumio[1337]: at TLSSocket.emit (node:events:526:35) Oct 13 18:26:36 volumio volumio[1337]: at endReadableNT (node:internal/streams/readable:1376:12) Oct 13 18:26:36 volumio volumio[1337]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Oct 13 18:26:36 volumio volumio[1337]: code: 'ECONNRESET', Oct 13 18:26:36 volumio volumio[1337]: path: null, Oct 13 18:26:36 volumio volumio[1337]: host: 'lastfm-img.freetls.fastly.net', Oct 13 18:26:36 volumio volumio[1337]: port: 443, Oct 13 18:26:36 volumio volumio[1337]: localAddress: undefined Oct 13 18:26:36 volumio volumio[1337]: } Oct 13 18:26:36 volumio volumio[1337]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 18:26:37 volumio sudo[2368]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 18:25' Oct 13 18:26:37 volumio sudo[2368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"