-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Wed 2024-07-17 16:44:30 CST. -- Jul 17 16:43:01 volumio-xzx kernel: usb 1-1.3: new high-speed USB device number 4 using dwc_otg Jul 17 16:43:01 volumio-xzx kernel: usb 1-1.3: New USB device found, idVendor=16d0, idProduct=071a, bcdDevice= 1.96 Jul 17 16:43:01 volumio-xzx kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jul 17 16:43:01 volumio-xzx kernel: usb 1-1.3: Product: Combo384 Amanero Jul 17 16:43:01 volumio-xzx kernel: usb 1-1.3: Manufacturer: Amanero Technologies Jul 17 16:43:01 volumio-xzx kernel: usb 1-1.3: SerialNumber: 413-001 Jul 17 16:43:02 volumio-xzx kernel: usb 1-1.3: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Jul 17 16:43:02 volumio-xzx kernel: usb 1-1.3: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Jul 17 16:43:02 volumio-xzx kernel: usb 1-1.3: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Jul 17 16:43:02 volumio-xzx kernel: usb 1-1.3: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Jul 17 16:43:02 volumio-xzx kernel: usbcore: registered new interface driver snd-usb-audio Jul 17 16:43:02 volumio-xzx systemd-udevd[3228]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Jul 17 16:43:02 volumio-xzx volumio[913]: info: Jul 17 16:43:02 volumio-xzx volumio[913]: ---------------------------- USB Audio Device Attached Jul 17 16:43:02 volumio-xzx volumio[913]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 17 16:43:21 volumio-xzx volumio[913]: info: Preload queue cleared Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::ClearQueue Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::stop Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::clearPlayQueue Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::saveQueue Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushQueue Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::addQueueItems Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::addQueueItems Jul 17 16:43:21 volumio-xzx volumio[913]: info: Preload queue cleared Jul 17 16:43:21 volumio-xzx volumio[913]: info: Adding Item to queue: albums://BEYOND/BEYOND%20%E6%9E%81%E5%93%81%E4%B9%8B%E9%80%89SACD Jul 17 16:43:21 volumio-xzx volumio[913]: info: Exploding uri albums://BEYOND/BEYOND%20%E6%9E%81%E5%93%81%E4%B9%8B%E9%80%89SACD in service mpd Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushQueue Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::saveQueue Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::updateTrackBlock Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrackBlock Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPlay Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::play index 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::stop Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::play index undefined Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::startPlaybackTimer Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::clearAddPlayTracks NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand stop took 6 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 16:43:21 volumio-xzx volumio[913]: info: Jul 17 16:43:21 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:43:21 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand clear took 5 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand add "NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf" Jul 17 16:43:21 volumio-xzx volumio[913]: info: Jul 17 16:43:21 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:43:21 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:43:21 volumio-xzx volumio[913]: error: updateQueue error: null Jul 17 16:43:21 volumio-xzx volumio[913]: info: Jul 17 16:43:21 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:43:21 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:43:21 volumio-xzx volumio[913]: info: ------------------------------ 17ms Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand add "NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf" took 13 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: ------------------------------ 9ms Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand play Jul 17 16:43:21 volumio-xzx volumio[913]: info: Jul 17 16:43:21 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:43:21 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:43:21 volumio-xzx volumio[913]: info: Jul 17 16:43:21 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:21 volumio-xzx volumio[913]: info: ------------------------------ 14ms Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand play took 11 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: ------------------------------ 10ms Jul 17 16:43:21 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:21 volumio-xzx volumio[913]: info: Jul 17 16:43:21 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:21 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:21 volumio-xzx volumio[913]: info: Jul 17 16:43:21 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:21 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand status took 18 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand status took 17 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:43:21 volumio-xzx volumio[913]: info: Jul 17 16:43:21 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:21 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand status took 33 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 25 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 23 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 15 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand status took 11 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:43:21 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Amani","artist":"BEYOND","album":"BEYOND 极品之选SACD","uri":"NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf","trackType":"dsf"} Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Amani","artist":"BEYOND","album":"BEYOND 极品之选SACD","uri":"NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf","trackType":"dsf"} Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: ------------------------------ 103ms Jul 17 16:43:21 volumio-xzx volumio[913]: info: ------------------------------ 99ms Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 73 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 67 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 64 milliseconds Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:43:21 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Amani","artist":"BEYOND","album":"BEYOND 极品之选SACD","uri":"NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf","trackType":"dsf"} Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Amani","artist":"BEYOND","album":"BEYOND 极品之选SACD","uri":"NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf","trackType":"dsf"} Jul 17 16:43:21 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:21 volumio-xzx volumio[913]: info: ------------------------------ 141ms Jul 17 16:43:21 volumio-xzx volumio[913]: info: ------------------------------ 118ms Jul 17 16:43:38 volumio-xzx volumio[913]: info: Preload queue cleared Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::ClearQueue Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::stop Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:43:38 volumio-xzx volumio[913]: info: CorePlayQueue::clearPlayQueue Jul 17 16:43:38 volumio-xzx volumio[913]: info: CorePlayQueue::saveQueue Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushQueue Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::addQueueItems Jul 17 16:43:38 volumio-xzx volumio[913]: info: CorePlayQueue::addQueueItems Jul 17 16:43:38 volumio-xzx volumio[913]: info: Preload queue cleared Jul 17 16:43:38 volumio-xzx volumio[913]: info: Adding Item to queue: albums://BEYOND/BEYOND%20%E6%9E%81%E5%93%81%E4%B9%8B%E9%80%89SACD Jul 17 16:43:38 volumio-xzx volumio[913]: info: Using cached record of: albums://BEYOND/BEYOND%20%E6%9E%81%E5%93%81%E4%B9%8B%E9%80%89SACD Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushQueue Jul 17 16:43:38 volumio-xzx volumio[913]: info: CorePlayQueue::saveQueue Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::updateTrackBlock Jul 17 16:43:38 volumio-xzx volumio[913]: info: CorePlayQueue::getTrackBlock Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPlay Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::play index 0 Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::stop Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::play index undefined Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:43:38 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::startPlaybackTimer Jul 17 16:43:38 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::clearAddPlayTracks NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 16:43:38 volumio-xzx volumio[913]: info: Jul 17 16:43:38 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:38 volumio-xzx volumio[913]: info: sendMpdCommand stop took 4 milliseconds Jul 17 16:43:38 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 16:43:38 volumio-xzx volumio[913]: info: Jul 17 16:43:38 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:43:38 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:43:38 volumio-xzx volumio[913]: info: sendMpdCommand status took 5 milliseconds Jul 17 16:43:38 volumio-xzx volumio[913]: info: sendMpdCommand clear took 5 milliseconds Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand add "NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf" Jul 17 16:43:38 volumio-xzx volumio[913]: info: Jul 17 16:43:38 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:38 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:38 volumio-xzx volumio[913]: error: updateQueue error: null Jul 17 16:43:38 volumio-xzx volumio[913]: info: Jul 17 16:43:38 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:43:38 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:43:38 volumio-xzx volumio[913]: info: ------------------------------ 8ms Jul 17 16:43:38 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 16:43:38 volumio-xzx volumio[913]: info: sendMpdCommand add "NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf" took 6 milliseconds Jul 17 16:43:38 volumio-xzx volumio[913]: info: sendMpdCommand status took 4 milliseconds Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand play Jul 17 16:43:38 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:38 volumio-xzx volumio[913]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 16:43:38 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:38 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:38 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: 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} Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService stop Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: No code Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: ------------------------------ 37ms Jul 17 16:43:39 volumio-xzx volumio[913]: info: ------------------------------ 47ms Jul 17 16:43:39 volumio-xzx volumio[913]: info: Jul 17 16:43:39 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:43:39 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:43:39 volumio-xzx volumio[913]: info: Jul 17 16:43:39 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:39 volumio-xzx volumio[913]: info: Jul 17 16:43:39 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:39 volumio-xzx volumio[913]: info: ------------------------------ 51ms Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand play took 47 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:39 volumio-xzx volumio[913]: info: ------------------------------ 7ms Jul 17 16:43:39 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:39 volumio-xzx volumio[913]: info: Jul 17 16:43:39 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:43:39 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand status took 11 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand status took 11 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand status took 10 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 16 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 15 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 13 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:43:39 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Amani","artist":"BEYOND","album":"BEYOND 极品之选SACD","uri":"NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf","trackType":"dsf"} Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Amani","artist":"BEYOND","album":"BEYOND 极品之选SACD","uri":"NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf","trackType":"dsf"} Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Amani","artist":"BEYOND","album":"BEYOND 极品之选SACD","uri":"NAS/我的NAS音乐/BEYOND - 极品之选/01、AMANI.dsf","trackType":"dsf"} Jul 17 16:43:39 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:43:39 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:43:39 volumio-xzx volumio[913]: info: ------------------------------ 66ms Jul 17 16:43:39 volumio-xzx volumio[913]: info: ------------------------------ 67ms Jul 17 16:43:39 volumio-xzx volumio[913]: info: ------------------------------ 64ms Jul 17 16:44:02 volumio-xzx volumio[913]: info: Preload queue cleared Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::ClearQueue Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::stop Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::clearPlayQueue Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::saveQueue Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushQueue Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::addQueueItems Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::addQueueItems Jul 17 16:44:02 volumio-xzx volumio[913]: info: Preload queue cleared Jul 17 16:44:02 volumio-xzx volumio[913]: info: Adding Item to queue: albums://%E7%BE%A4%E6%98%9F/%E3%80%8A%E5%8D%81%E5%85%AB%E5%90%8D%E4%BD%9C%C2%B7%E5%8F%91%E7%83%A7%E4%BA%BA%E5%A3%B0%E7%AF%87%20DSD%E3%80%8B Jul 17 16:44:02 volumio-xzx volumio[913]: info: Exploding uri albums://%E7%BE%A4%E6%98%9F/%E3%80%8A%E5%8D%81%E5%85%AB%E5%90%8D%E4%BD%9C%C2%B7%E5%8F%91%E7%83%A7%E4%BA%BA%E5%A3%B0%E7%AF%87%20DSD%E3%80%8B in service mpd Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushQueue Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::saveQueue Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::updateTrackBlock Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::getTrackBlock Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPlay Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::play index 0 Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::stop Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::play index undefined Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::startPlaybackTimer Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::clearAddPlayTracks NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand stop took 3 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:02 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:02 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand status took 6 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand clear took 7 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand status took 3 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand add "NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav" Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:02 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:02 volumio-xzx volumio[913]: 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} Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService stop Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:02 volumio-xzx volumio[913]: info: No code Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:02 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:02 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:02 volumio-xzx volumio[913]: info: ------------------------------ 38ms Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:02 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:02 volumio-xzx volumio[913]: error: updateQueue error: null Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:02 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:02 volumio-xzx volumio[913]: info: ------------------------------ 53ms Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 51 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand add "NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav" took 50 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: info: ------------------------------ 18ms Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand play Jul 17 16:44:02 volumio-xzx volumio[913]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 16:44:02 volumio-xzx volumio[913]: info: ------------------------------ 65ms Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:02 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:02 volumio-xzx volumio[913]: info: ------------------------------ 28ms Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand play took 13 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:02 volumio-xzx volumio[913]: info: ------------------------------ 12ms Jul 17 16:44:02 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:02 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand status took 11 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand status took 11 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:02 volumio-xzx volumio[913]: info: sendMpdCommand status took 10 milliseconds Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:02 volumio-xzx volumio[913]: info: Jul 17 16:44:02 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:02 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:02 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:03 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 43 milliseconds Jul 17 16:44:03 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 43 milliseconds Jul 17 16:44:03 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 42 milliseconds Jul 17 16:44:03 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 17 16:44:03 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 25 milliseconds Jul 17 16:44:03 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 22 milliseconds Jul 17 16:44:03 volumio-xzx volumio[913]: info: sendMpdCommand status took 14 milliseconds Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:03 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: ------------------------------ 108ms Jul 17 16:44:03 volumio-xzx volumio[913]: info: ------------------------------ 107ms Jul 17 16:44:03 volumio-xzx volumio[913]: info: ------------------------------ 104ms Jul 17 16:44:03 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 57 milliseconds Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:03 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:03 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:03 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:03 volumio-xzx volumio[913]: info: ------------------------------ 94ms Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPlay Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::play index undefined Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::startPlaybackTimer Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::clearAddPlayTracks NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand stop took 4 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:08 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand status took 5 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand clear took 5 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand status took 3 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand add "NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav" Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: 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} Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService stop Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: No code Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 34ms Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:08 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:08 volumio-xzx volumio[913]: error: updateQueue error: null Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:08 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 37ms Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 34 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand add "NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav" took 35 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 5ms Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand play Jul 17 16:44:08 volumio-xzx volumio[913]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 48ms Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:08 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 17ms Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand play took 14 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 10ms Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:08 volumio-xzx volumio[913]: info: Jul 17 16:44:08 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand status took 12 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand status took 13 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand status took 12 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 14 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 13 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 12 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:08 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:08 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 66ms Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 66ms Jul 17 16:44:08 volumio-xzx volumio[913]: info: ------------------------------ 64ms Jul 17 16:44:21 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioGetState Jul 17 16:44:21 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPlay Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::play index undefined Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::startPlaybackTimer Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::clearAddPlayTracks NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand stop took 3 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:25 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand status took 14 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand clear took 15 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand add "NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav" Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:25 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:25 volumio-xzx volumio[913]: error: updateQueue error: null Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:25 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand status took 10 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 8ms Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand add "NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav" took 7 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 6ms Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand play Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: 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} Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService stop Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: No code Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:25 volumio-xzx volumio[913]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 64ms Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 69ms Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces system playlist update Jul 17 16:44:25 volumio-xzx volumio[913]: info: Ignoring MPD Status Update Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 53ms Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand play took 49 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 6ms Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:25 volumio-xzx volumio[913]: info: Jul 17 16:44:25 volumio-xzx volumio[913]: ---------------------------- MPD announces state update: player Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::getState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand status Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand status took 15 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand status took 15 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand status took 14 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseState Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 20 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 19 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand clearerror took 18 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: ControllerMpd::parseTrackInfo Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: ControllerMpd::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::servicePushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 一曲销魂","artist":"群星","album":"《十八名作·发烧人声篇 DSD》","uri":"NAS/我的NAS音乐/【清泉收藏】《十八名作·发烧人声篇 DSD》/01 一曲销魂.wav","trackType":"wav"} Jul 17 16:44:25 volumio-xzx volumio[913]: verbose: CURRENT POSITION 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::syncState stateService pause Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreStateMachine::pushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: CorePlayQueue::getTrack 0 Jul 17 16:44:25 volumio-xzx volumio[913]: info: CoreCommandRouter::volumioPushState Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 82ms Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 82ms Jul 17 16:44:25 volumio-xzx volumio[913]: info: ------------------------------ 78ms Jul 17 16:44:29 volumio-xzx volumio[913]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 16:44:29 volumio-xzx volumio[913]: Error: connect ETIMEDOUT 31.13.96.195:443 Jul 17 16:44:29 volumio-xzx volumio[913]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jul 17 16:44:29 volumio-xzx volumio[913]: errno: -110, Jul 17 16:44:29 volumio-xzx volumio[913]: code: 'ETIMEDOUT', Jul 17 16:44:29 volumio-xzx volumio[913]: syscall: 'connect', Jul 17 16:44:29 volumio-xzx volumio[913]: address: '31.13.96.195', Jul 17 16:44:29 volumio-xzx volumio[913]: port: 443 Jul 17 16:44:29 volumio-xzx volumio[913]: } Jul 17 16:44:29 volumio-xzx volumio[913]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 16:44:30 volumio-xzx sudo[3338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-17 16:43 Jul 17 16:44:30 volumio-xzx sudo[3338]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"