-- Logs begin at Wed 2024-07-17 02:44:19 +12, end at Wed 2024-07-17 02:46:09 +12. -- Jul 17 02:45:00 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 02:45:00 volumio volumio[849]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 17 02:45:00 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Jul 17 02:45:00 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:01 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jul 17 02:45:03 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 02:45:03 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 02:45:03 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 02:45:04 volumio volumio-remote-updater[617]: No test mode Jul 17 02:45:04 volumio volumio-remote-updater[617]: No alpha test mode Jul 17 02:45:04 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 17 02:45:05 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 02:45:05 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 02:45:05 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 17 02:45:05 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 02:45:05 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 17 02:45:05 volumio volumio[849]: info: CoreCommandRouter::volumioGetBrowseSources Jul 17 02:45:05 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 02:45:06 volumio volumio[849]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 17 02:45:06 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 17 02:45:06 volumio volumio[849]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 17 02:45:06 volumio volumio[849]: info: Completed starting MyVolumio Plugin Jul 17 02:45:06 volumio volumio[849]: info: BOOT COMPLETED Jul 17 02:45:06 volumio volumio[849]: [Metrics] CommandRouter: 40s 346.89ms Jul 17 02:45:06 volumio volumio[849]: info: CoreCommandRouter::volumiosetStartupVolume Jul 17 02:45:06 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 02:45:06 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 02:45:06 volumio volumio[849]: info: CoreCommandRouter::Close All Modals sent Jul 17 02:45:06 volumio volumio[849]: info: CoreCommandRouter::Close All Modals sent Jul 17 02:45:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 17 02:45:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 02:45:07 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 17 02:45:15 volumio volumio[849]: info: CoreCommandRouter::volumioPlay Jul 17 02:45:15 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:15 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:15 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:15 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:15 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:15 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac Jul 17 02:45:15 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:15 volumio volumio[849]: info: sendMpdCommand stop took 2 milliseconds Jul 17 02:45:15 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:15 volumio volumio[849]: info: Jul 17 02:45:15 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:15 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:15 volumio volumio[849]: info: sendMpdCommand clear took 9 milliseconds Jul 17 02:45:15 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac" Jul 17 02:45:15 volumio volumio[849]: info: Jul 17 02:45:15 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:15 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:15 volumio volumio[849]: info: Jul 17 02:45:15 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:15 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:15 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:15 volumio volumio[849]: info: Jul 17 02:45:15 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:15 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:15 volumio volumio[849]: info: ------------------------------ 9ms Jul 17 02:45:15 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac" took 7 milliseconds Jul 17 02:45:15 volumio volumio[849]: info: ------------------------------ 6ms Jul 17 02:45:15 volumio volumio[849]: info: ------------------------------ 6ms Jul 17 02:45:15 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:15 volumio volumio[849]: info: Jul 17 02:45:15 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:15 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:15 volumio volumio[849]: info: Jul 17 02:45:15 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:15 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:15 volumio volumio[849]: info: ------------------------------ 14ms Jul 17 02:45:15 volumio volumio[849]: info: sendMpdCommand play took 12 milliseconds Jul 17 02:45:15 volumio volumio[849]: info: ------------------------------ 10ms Jul 17 02:45:15 volumio volumio[849]: info: ------------------------------ 9ms Jul 17 02:45:16 volumio volumio[849]: info: Jul 17 02:45:16 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:16 volumio volumio[849]: info: Jul 17 02:45:16 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:16 volumio volumio[849]: info: Jul 17 02:45:16 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:16 volumio volumio[849]: info: Jul 17 02:45:16 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand status took 106 milliseconds Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand status took 106 milliseconds Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:16 volumio volumio[849]: info: Jul 17 02:45:16 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand status took 110 milliseconds Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand status took 6 milliseconds Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1347 Kbps","isStreaming":false,"title":"7ef8d81556be7df13703d1883607f1ae_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac","trackType":"flac"} Jul 17 02:45:16 volumio volumio[849]: verbose: CURRENT POSITION 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1364 Kbps","isStreaming":false,"title":"7ef8d81556be7df13703d1883607f1ae_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac","trackType":"flac"} Jul 17 02:45:16 volumio volumio[849]: verbose: CURRENT POSITION 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:16 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: ------------------------------ 133ms Jul 17 02:45:16 volumio volumio[849]: info: ------------------------------ 139ms Jul 17 02:45:16 volumio volumio[849]: info: Jul 17 02:45:16 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand playlistinfo took 26 milliseconds Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand playlistinfo took 24 milliseconds Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1371 Kbps","isStreaming":false,"title":"7ef8d81556be7df13703d1883607f1ae_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac","trackType":"flac"} Jul 17 02:45:16 volumio volumio[849]: verbose: CURRENT POSITION 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:16 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1371 Kbps","isStreaming":false,"title":"7ef8d81556be7df13703d1883607f1ae_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac","trackType":"flac"} Jul 17 02:45:16 volumio volumio[849]: verbose: CURRENT POSITION 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:16 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1371 Kbps","isStreaming":false,"title":"7ef8d81556be7df13703d1883607f1ae_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac","trackType":"flac"} Jul 17 02:45:16 volumio volumio[849]: verbose: CURRENT POSITION 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:16 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: ------------------------------ 191ms Jul 17 02:45:16 volumio volumio[849]: info: ------------------------------ 88ms Jul 17 02:45:16 volumio volumio[849]: info: ------------------------------ 83ms Jul 17 02:45:16 volumio volumio[849]: info: sendMpdCommand playlistinfo took 60 milliseconds Jul 17 02:45:16 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:16 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1371 Kbps","isStreaming":false,"title":"7ef8d81556be7df13703d1883607f1ae_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac","trackType":"flac"} Jul 17 02:45:16 volumio volumio[849]: verbose: CURRENT POSITION 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:16 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:16 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:16 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:16 volumio volumio[849]: info: ------------------------------ 80ms Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::stPlaybackTimer Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::serviceStop Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::serviceStop Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::stop Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand stop took 29 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 11 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand stop took 7 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 5 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 2 milliseconds Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:20 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand clear took 5 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac" Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"7ef8d81556be7df13703d1883607f1ae_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/7ef8d81556be7df13703d1883607f1ae_DSD.flac","trackType":"flac"} Jul 17 02:45:20 volumio volumio[849]: verbose: CURRENT POSITION 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: No code Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:20 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 44ms Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 37ms Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 36ms Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:20 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:20 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:20 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:20 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 38ms Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac" took 33 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 10ms Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:20 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:20 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 16ms Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand play took 10 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 10ms Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Various%20Artists/60a5e1be-2c81-4e58-bb5a-feaa8c980b53.jpg' Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 30 milliseconds Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 31 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 29 milliseconds Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: info: Jul 17 02:45:20 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 9 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"TS_109b - What Could Have Been","artist":"Various Artists","album":null,"uri":"USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac","trackType":"flac"} Jul 17 02:45:20 volumio volumio[849]: verbose: CURRENT POSITION 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"TS_109b - What Could Have Been","artist":"Various Artists","album":null,"uri":"USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac","trackType":"flac"} Jul 17 02:45:20 volumio volumio[849]: verbose: CURRENT POSITION 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:20 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1141 Kbps","isStreaming":false,"title":"TS_109b - What Could Have Been","artist":"Various Artists","album":null,"uri":"USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac","trackType":"flac"} Jul 17 02:45:20 volumio volumio[849]: verbose: CURRENT POSITION 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:20 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 60ms Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 79ms Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 79ms Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 43 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand status took 42 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 40 milliseconds Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1140 Kbps","isStreaming":false,"title":"TS_109b - What Could Have Been","artist":"Various Artists","album":null,"uri":"USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac","trackType":"flac"} Jul 17 02:45:20 volumio volumio[849]: verbose: CURRENT POSITION 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:20 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 76ms Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 34 milliseconds Jul 17 02:45:20 volumio volumio[849]: info: sendMpdCommand playlistinfo took 33 milliseconds Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1116 Kbps","isStreaming":false,"title":"TS_109b - What Could Have Been","artist":"Various Artists","album":null,"uri":"USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac","trackType":"flac"} Jul 17 02:45:20 volumio volumio[849]: verbose: CURRENT POSITION 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:20 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1116 Kbps","isStreaming":false,"title":"TS_109b - What Could Have Been","artist":"Various Artists","album":null,"uri":"USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac","trackType":"flac"} Jul 17 02:45:20 volumio volumio[849]: verbose: CURRENT POSITION 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:20 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:20 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:20 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 122ms Jul 17 02:45:20 volumio volumio[849]: info: ------------------------------ 122ms Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::stPlaybackTimer Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::serviceStop Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrack 1 Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::serviceStop Jul 17 02:45:21 volumio volumio[849]: info: ControllerMpd::stop Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand stop took 23 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:21 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:21 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand status took 6 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand stop took 5 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand status took 2 milliseconds Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:21 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand clear took 4 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac" Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:21 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:21 volumio volumio[849]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"TS_109b - What Could Have Been","artist":"Various Artists","album":null,"uri":"USB/系统/FLAC/862765c97db92713a7aea375d7bed3cd_DSD.flac","trackType":"flac"} Jul 17 02:45:21 volumio volumio[849]: verbose: CURRENT POSITION 2 Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:21 volumio volumio[849]: info: No code Jul 17 02:45:21 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:21 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:21 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:21 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:21 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 37ms Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 35ms Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 33ms Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:21 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:21 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:21 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:21 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 32ms Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac" took 30 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 5ms Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 4ms Jul 17 02:45:21 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:21 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:21 volumio volumio[849]: info: Jul 17 02:45:21 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:21 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 9ms Jul 17 02:45:21 volumio volumio[849]: info: sendMpdCommand play took 8 milliseconds Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 6ms Jul 17 02:45:21 volumio volumio[849]: info: ------------------------------ 5ms Jul 17 02:45:22 volumio volumio[849]: info: Jul 17 02:45:22 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:22 volumio volumio[849]: info: Jul 17 02:45:22 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:22 volumio volumio[849]: info: Jul 17 02:45:22 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:22 volumio volumio[849]: info: Jul 17 02:45:22 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand status took 102 milliseconds Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:22 volumio volumio[849]: info: Jul 17 02:45:22 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:22 volumio volumio[849]: info: Jul 17 02:45:22 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand status took 111 milliseconds Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand status took 112 milliseconds Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand status took 13 milliseconds Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1127 Kbps","isStreaming":false,"title":"a230c2d50e7b31b284a613bc806c89d1_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac","trackType":"flac"} Jul 17 02:45:22 volumio volumio[849]: verbose: CURRENT POSITION 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:22 volumio volumio[849]: info: ------------------------------ 123ms Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand status took 13 milliseconds Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand status took 12 milliseconds Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1424 Kbps","isStreaming":false,"title":"a230c2d50e7b31b284a613bc806c89d1_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac","trackType":"flac"} Jul 17 02:45:22 volumio volumio[849]: verbose: CURRENT POSITION 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:22 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":626,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1424 Kbps","isStreaming":false,"title":"a230c2d50e7b31b284a613bc806c89d1_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac","trackType":"flac"} Jul 17 02:45:22 volumio volumio[849]: verbose: CURRENT POSITION 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:22 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":626,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1294 Kbps","isStreaming":false,"title":"a230c2d50e7b31b284a613bc806c89d1_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac","trackType":"flac"} Jul 17 02:45:22 volumio volumio[849]: verbose: CURRENT POSITION 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:22 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: ------------------------------ 175ms Jul 17 02:45:22 volumio volumio[849]: info: ------------------------------ 76ms Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand playlistinfo took 55 milliseconds Jul 17 02:45:22 volumio volumio[849]: info: sendMpdCommand playlistinfo took 53 milliseconds Jul 17 02:45:22 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1317 Kbps","isStreaming":false,"title":"a230c2d50e7b31b284a613bc806c89d1_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac","trackType":"flac"} Jul 17 02:45:22 volumio volumio[849]: verbose: CURRENT POSITION 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:22 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1317 Kbps","isStreaming":false,"title":"a230c2d50e7b31b284a613bc806c89d1_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac","trackType":"flac"} Jul 17 02:45:22 volumio volumio[849]: verbose: CURRENT POSITION 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:22 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:22 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:22 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:22 volumio volumio[849]: info: ------------------------------ 104ms Jul 17 02:45:22 volumio volumio[849]: info: ------------------------------ 104ms Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::stPlaybackTimer Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::serviceStop Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 2 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::serviceStop Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::stop Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand stop took 23 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/Aneela - Hope_SQ.flac Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 8 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand stop took 6 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 5 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:23 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand clear took 4 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/Aneela - Hope_SQ.flac" Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"a230c2d50e7b31b284a613bc806c89d1_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/a230c2d50e7b31b284a613bc806c89d1_DSD.flac","trackType":"flac"} Jul 17 02:45:23 volumio volumio[849]: verbose: CURRENT POSITION 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: No code Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 43ms Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 38ms Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 37ms Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:23 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:23 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:23 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:23 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 45ms Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/Aneela - Hope_SQ.flac" took 44 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 17ms Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 4ms Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:23 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:23 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 22ms Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand play took 22 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 21ms Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 12ms Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 103 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 103 milliseconds Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 101 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":168,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"Aneela - Hope_SQ.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/Aneela - Hope_SQ.flac","trackType":"flac"} Jul 17 02:45:23 volumio volumio[849]: verbose: CURRENT POSITION 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 109ms Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: Jul 17 02:45:23 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 6 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand status took 2 milliseconds Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":168,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"318 Kbps","isStreaming":false,"title":"Aneela - Hope_SQ.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/Aneela - Hope_SQ.flac","trackType":"flac"} Jul 17 02:45:23 volumio volumio[849]: verbose: CURRENT POSITION 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:23 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":682,"duration":168,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"406 Kbps","isStreaming":false,"title":"Aneela - Hope_SQ.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/Aneela - Hope_SQ.flac","trackType":"flac"} Jul 17 02:45:23 volumio volumio[849]: verbose: CURRENT POSITION 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:23 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 141ms Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 141ms Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand playlistinfo took 31 milliseconds Jul 17 02:45:23 volumio volumio[849]: info: sendMpdCommand playlistinfo took 30 milliseconds Jul 17 02:45:23 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":168,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"600 Kbps","isStreaming":false,"title":"Aneela - Hope_SQ.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/Aneela - Hope_SQ.flac","trackType":"flac"} Jul 17 02:45:23 volumio volumio[849]: verbose: CURRENT POSITION 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:23 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":168,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"600 Kbps","isStreaming":false,"title":"Aneela - Hope_SQ.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/Aneela - Hope_SQ.flac","trackType":"flac"} Jul 17 02:45:23 volumio volumio[849]: verbose: CURRENT POSITION 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:23 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":168,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"600 Kbps","isStreaming":false,"title":"Aneela - Hope_SQ.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/Aneela - Hope_SQ.flac","trackType":"flac"} Jul 17 02:45:23 volumio volumio[849]: verbose: CURRENT POSITION 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:23 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:23 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:23 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 107ms Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 104ms Jul 17 02:45:23 volumio volumio[849]: info: ------------------------------ 104ms Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::stPlaybackTimer Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::serviceStop Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 3 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::serviceStop Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::stop Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand stop took 34 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 6 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand stop took 5 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 2 milliseconds Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:24 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand clear took 3 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac" Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Aneela - Hope_SQ.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/Aneela - Hope_SQ.flac","trackType":"flac"} Jul 17 02:45:24 volumio volumio[849]: verbose: CURRENT POSITION 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: No code Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:24 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 46ms Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 42ms Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 41ms Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:24 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:24 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:24 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:24 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 43ms Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac" took 41 milliseconds Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:24 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 12ms Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 9ms Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand play took 7 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 6ms Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:24 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 2ms Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 102 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: info: Jul 17 02:45:24 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 106 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 105 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 6 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"AZ珍珍 - 一滴眼泪一条河_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac","trackType":"flac"} Jul 17 02:45:24 volumio volumio[849]: verbose: CURRENT POSITION 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 115ms Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand status took 8 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"678 Kbps","isStreaming":false,"title":"AZ珍珍 - 一滴眼泪一条河_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac","trackType":"flac"} Jul 17 02:45:24 volumio volumio[849]: verbose: CURRENT POSITION 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:24 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"678 Kbps","isStreaming":false,"title":"AZ珍珍 - 一滴眼泪一条河_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac","trackType":"flac"} Jul 17 02:45:24 volumio volumio[849]: verbose: CURRENT POSITION 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:24 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"678 Kbps","isStreaming":false,"title":"AZ珍珍 - 一滴眼泪一条河_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac","trackType":"flac"} Jul 17 02:45:24 volumio volumio[849]: verbose: CURRENT POSITION 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:24 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"678 Kbps","isStreaming":false,"title":"AZ珍珍 - 一滴眼泪一条河_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac","trackType":"flac"} Jul 17 02:45:24 volumio volumio[849]: verbose: CURRENT POSITION 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:24 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 175ms Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 174ms Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 74ms Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 73ms Jul 17 02:45:24 volumio volumio[849]: info: sendMpdCommand playlistinfo took 63 milliseconds Jul 17 02:45:24 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:24 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"678 Kbps","isStreaming":false,"title":"AZ珍珍 - 一滴眼泪一条河_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac","trackType":"flac"} Jul 17 02:45:24 volumio volumio[849]: verbose: CURRENT POSITION 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:24 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:24 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:24 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:24 volumio volumio[849]: info: ------------------------------ 89ms Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::stPlaybackTimer Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::serviceStop Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 4 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::serviceStop Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::stop Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand stop took 25 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/AZ珍珍 - 午夜时分_DSD.flac Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand stop took 2 milliseconds Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand clear took 3 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 2 milliseconds Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/AZ珍珍 - 午夜时分_DSD.flac" Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AZ珍珍 - 一滴眼泪一条河_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 一滴眼泪一条河_DSD.flac","trackType":"flac"} Jul 17 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: No code Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: No code Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: No code Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 5 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 62ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 58ms Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 70ms Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/AZ珍珍 - 午夜时分_DSD.flac" took 69 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 14ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 9ms Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 23ms Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand play took 23 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 18ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 17ms Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/AZ珍珍 - 我听过_DSD.flac Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 101 milliseconds Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 129 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 123 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand stop took 54 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 29 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1151 Kbps","isStreaming":false,"title":"AZ珍珍 - 午夜时分_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 午夜时分_DSD.flac","trackType":"flac"} Jul 17 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 136ms Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 9 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 9 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 8 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand clear took 8 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 4 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/AZ珍珍 - 我听过_DSD.flac" Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":717,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1445 Kbps","isStreaming":false,"title":"AZ珍珍 - 午夜时分_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 午夜时分_DSD.flac","trackType":"flac"} Jul 17 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:25 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":237,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1445 Kbps","isStreaming":false,"title":"AZ珍珍 - 午夜时分_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 午夜时分_DSD.flac","trackType":"flac"} Jul 17 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:25 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 6 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 6 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: No code Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 203ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 198ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 77ms Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/AZ珍珍 - 缘深换缘浅_DSD.flac Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 71ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 70ms Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 90ms Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 86 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 86 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 87 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/AZ珍珍 - 我听过_DSD.flac" took 86 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand stop took 23 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 7ms Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:25 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:25 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:25 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 107ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 106ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 106ms Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 21ms Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand play took 14 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand clear took 14 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 6ms Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/AZ珍珍 - 缘深换缘浅_DSD.flac" Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 23ms Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 22 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/AZ珍珍 - 缘深换缘浅_DSD.flac" took 20 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 19ms Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 16 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 15ms Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 10 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: No code Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: No code Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: No code Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 7 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 97ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 92ms Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 84ms Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 85ms Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand play took 80 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 8 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 8 Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/e7f72884a2b157f07964d032117b20f3_DSD.flac Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 81 milliseconds Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/In-Grid - I'm folle de toi_SQ.flac Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 111 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 110 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand stop took 91 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 32 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 31 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand stop took 20 milliseconds Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AZ珍珍 - 缘深换缘浅_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 缘深换缘浅_DSD.flac","trackType":"flac"} Jul 17 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: ------------------------------ 119ms Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: Jul 17 02:45:25 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:25 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 11 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 10 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 8 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand clear took 7 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand clear took 6 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 4 milliseconds Jul 17 02:45:25 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/e7f72884a2b157f07964d032117b20f3_DSD.flac" Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/In-Grid - I'm folle de toi_SQ.flac" Jul 17 02:45:25 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1008 Kbps","isStreaming":false,"title":"AZ珍珍 - 缘深换缘浅_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 缘深换缘浅_DSD.flac","trackType":"flac"} Jul 17 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:25 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":580,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"987 Kbps","isStreaming":false,"title":"AZ珍珍 - 缘深换缘浅_DSD.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/AZ珍珍 - 缘深换缘浅_DSD.flac","trackType":"flac"} Jul 17 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:25 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 9 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 9 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 10 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 10 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 10 Jul 17 02:45:25 volumio volumio[849]: 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 02:45:25 volumio volumio[849]: verbose: CURRENT POSITION 10 Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 10 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:25 volumio volumio[849]: info: No code Jul 17 02:45:25 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:25 volumio volumio[849]: info: CorePlayQueue::getTrack 10 Jul 17 02:45:25 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 212ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 211ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 130ms Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 10 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 10 Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/Michael Bublé - My Valentine_DSD.flac Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 100ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 102ms Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 10 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:26 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 116ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 114 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 115 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 111 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/e7f72884a2b157f07964d032117b20f3_DSD.flac" took 110 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/In-Grid - I'm folle de toi_SQ.flac" took 108 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand stop took 24 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 7ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 6ms Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:26 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:26 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:26 volumio volumio[849]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 133ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 133ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 133ms Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 18ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 18ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand play took 15 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand play took 14 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioNext Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::next Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::stop Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::play index undefined Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::startPlaybackTimer Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand clear took 52 milliseconds Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/Michael Bublé - My Valentine_DSD.flac" Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 51ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 42ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand stop took 10 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/Michael Bublé - My Valentine_DSD.flac" took 2 milliseconds Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:26 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 6 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand clear took 6 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand play took 6 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 5ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 4 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 4ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 3 milliseconds Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac" Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: 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 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: No code Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: 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 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: No code Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: 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 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService stop Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: No code Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 68ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 66ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 64ms Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: error: updateQueue error: null Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 67ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand add "USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac" took 64 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 3ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 2ms Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand play Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces system playlist update Jul 17 02:45:26 volumio volumio[849]: info: Ignoring MPD Status Update Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 11ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand play took 10 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 8ms Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 101 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: info: Jul 17 02:45:26 volumio volumio[849]: ---------------------------- MPD announces state update: player Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::getState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand status Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 104 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 103 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 4 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","trackType":"flac"} Jul 17 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus stop Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 110ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 7 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand status took 6 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseState Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":717,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"763 Kbps","isStreaming":false,"title":"SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","trackType":"flac"} Jul 17 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:26 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"763 Kbps","isStreaming":false,"title":"SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","trackType":"flac"} Jul 17 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:26 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"763 Kbps","isStreaming":false,"title":"SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","trackType":"flac"} Jul 17 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:26 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 155ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 155ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 56ms Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 47 milliseconds Jul 17 02:45:26 volumio volumio[849]: info: sendMpdCommand playlistinfo took 47 milliseconds Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:26 volumio volumio[849]: verbose: ControllerMpd::parseTrackInfo Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"763 Kbps","isStreaming":false,"title":"SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","trackType":"flac"} Jul 17 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:26 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ControllerMpd::pushState Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::servicePushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"763 Kbps","isStreaming":false,"title":"SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","artist":null,"album":null,"uri":"USB/系统/FLAC/SHARON_敏兒 - 钟爱一人 (粤语)_DSD1.flac","trackType":"flac"} Jul 17 02:45:26 volumio volumio[849]: verbose: CURRENT POSITION 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState stateService play Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::syncState currentStatus play Jul 17 02:45:26 volumio volumio[849]: info: Received an update from plugin. extracting info from payload Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: CoreStateMachine::pushState Jul 17 02:45:26 volumio volumio[849]: info: CorePlayQueue::getTrack 11 Jul 17 02:45:26 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 115ms Jul 17 02:45:26 volumio volumio[849]: info: ------------------------------ 115ms Jul 17 02:46:02 volumio volumio[849]: info: CoreCommandRouter::volumioGetQueue Jul 17 02:46:02 volumio volumio[849]: info: CoreStateMachine::getQueue Jul 17 02:46:02 volumio volumio[849]: info: CorePlayQueue::getQueue Jul 17 02:46:05 volumio volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alan%20Tam/c617cb9e-4bb2-4b1e-9792-0a255f6ecb84.jpg' Jul 17 02:46:05 volumio volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%8E%E8%B0%B7%E4%B8%80/20%E4%B8%96%E7%BA%AA%E4%B8%AD%E5%8D%8E%E6%AD%8C%E5%9D%9B%E5%90%8D%E4%BA%BA%E7%99%BE%E9%9B%86%E7%8F%8D%E8%97%8F%E7%89%88/54bb362f-0450-4ef3-a2df-e90d40f872ae.jpg' Jul 17 02:46:05 volumio volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nat%20King%20Cole/Cole%20Espa%C3%B1ol/7c5d09e6-df77-4c16-b540-6bc086383a8f.jpg' Jul 17 02:46:09 volumio volumio[849]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 02:46:09 volumio volumio[849]: Error: connect ECONNREFUSED 162.220.12.226:80 Jul 17 02:46:09 volumio volumio[849]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 17 02:46:09 volumio volumio[849]: errno: -111, Jul 17 02:46:09 volumio volumio[849]: code: 'ECONNREFUSED', Jul 17 02:46:09 volumio volumio[849]: syscall: 'connect', Jul 17 02:46:09 volumio volumio[849]: address: '162.220.12.226', Jul 17 02:46:09 volumio volumio[849]: port: 80 Jul 17 02:46:09 volumio volumio[849]: } Jul 17 02:46:09 volumio volumio[849]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 02:46:09 volumio sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-17 02:45 Jul 17 02:46:09 volumio sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"