-- Logs begin at Tue 2025-04-15 05:53:31 UTC, end at Wed 2025-04-16 07:50:19 UTC. -- Apr 16 07:49:11 volumio-n1-sxkj smbd[22877]: [2025/04/16 07:49:11.462051, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 16 07:49:11 volumio-n1-sxkj smbd[22877]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 16 07:49:11 volumio-n1-sxkj smbd[22877]: [2025/04/16 07:49:11.462669, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 16 07:49:11 volumio-n1-sxkj smbd[22877]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 16 07:49:11 volumio-n1-sxkj smbd[22877]: [2025/04/16 07:49:11.475523, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 16 07:49:11 volumio-n1-sxkj smbd[22877]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: update Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: Command Router : Notfying DB Updatetrue Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::Close All Modals sent Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService stop Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: No code Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 104ms Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: MPD Database updated - AlbumList cache refreshed Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: database Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: update Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 60ms Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: Command Router : Notfying DB Updatefalse Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::Close All Modals sent Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService stop Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: No code Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService stop Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: No code Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 0 Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 151ms Apr 16 07:49:27 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 151ms Apr 16 07:49:28 volumio-n1-sxkj dhcpd[5427]: DHCPDISCOVER from 00:90:4c:c5:12:38 (volumio-n1-sxkj) via wlan0 Apr 16 07:49:29 volumio-n1-sxkj dhcpd[5427]: DHCPOFFER on 192.168.211.2 to 00:90:4c:c5:12:38 (volumio-n1-sxkj) via wlan0 Apr 16 07:49:45 volumio-n1-sxkj smbd[22999]: [2025/04/16 07:49:45.302301, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 16 07:49:45 volumio-n1-sxkj smbd[22999]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 16 07:49:45 volumio-n1-sxkj smbd[22999]: [2025/04/16 07:49:45.302920, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 16 07:49:45 volumio-n1-sxkj smbd[22999]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 16 07:49:45 volumio-n1-sxkj smbd[22999]: [2025/04/16 07:49:45.315687, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 16 07:49:45 volumio-n1-sxkj smbd[22999]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioNext Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::next Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stop Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: UNSET VOLATILE Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::play index undefined Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::startPlaybackTimer Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::clearAddPlayTracks USB/ABC4F8AA85082ED6/Music/1 经典天籁/James Horner - Horner： For The Love Of A Princess.flac Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand add "USB/ABC4F8AA85082ED6/Music/1 经典天籁/James Horner - Horner： For The Love Of A Princess.flac" Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: error: updateQueue error: null Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 7ms Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand play Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 6ms Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"502 Kbps","isStreaming":false,"title":"Horner: For The Love Of A Princess","artist":"James Horner","album":"Braveheart (Original Motion Picture Soundtrack) ","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/James Horner - Horner： For The Love Of A Princess.flac","trackType":"flac"} Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 29ms Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"502 Kbps","isStreaming":false,"title":"Horner: For The Love Of A Princess","artist":"James Horner","album":"Braveheart (Original Motion Picture Soundtrack) ","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/James Horner - Horner： For The Love Of A Princess.flac","trackType":"flac"} Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:53 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 76ms Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioNext Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::next Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: UNSET VOLATILE Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stPlaybackTimer Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::serviceStop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 1 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::serviceStop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::stop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::play index undefined Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::startPlaybackTimer Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::clearAddPlayTracks USB/ABC4F8AA85082ED6/Music/1 经典天籁/The City of Prague Philharmonic Orchestra - Arrival of the Birds.flac Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand add "USB/ABC4F8AA85082ED6/Music/1 经典天籁/The City of Prague Philharmonic Orchestra - Arrival of the Birds.flac" Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: 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":"Horner: For The Love Of A Princess","artist":"James Horner","album":"Braveheart (Original Motion Picture Soundtrack) ","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/James Horner - Horner： For The Love Of A Princess.flac","trackType":"flac"} Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService stop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: No code Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 58ms Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: error: updateQueue error: null Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 42ms Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand play Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 17ms Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":444,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"444 Kbps","isStreaming":false,"title":"Arrival of the Birds / Exodus (From \"The Crimson Wing: Mystery of the Flamingos\")","artist":"The City of Prague Philharmonic Orchestra","album":"100 Greatest Film Themes - Take 3","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/The City of Prague Philharmonic Orchestra - Arrival of the Birds.flac","trackType":"flac"} Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 29ms Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":444,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"444 Kbps","isStreaming":false,"title":"Arrival of the Birds / Exodus (From \"The Crimson Wing: Mystery of the Flamingos\")","artist":"The City of Prague Philharmonic Orchestra","album":"100 Greatest Film Themes - Take 3","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/The City of Prague Philharmonic Orchestra - Arrival of the Birds.flac","trackType":"flac"} Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:54 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 52ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioNext Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::next Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: UNSET VOLATILE Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stPlaybackTimer Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::serviceStop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 2 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::serviceStop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::play index undefined Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::startPlaybackTimer Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::clearAddPlayTracks USB/ABC4F8AA85082ED6/Music/1 经典天籁/Desert Skies - 马克西姆.姆尔维察.mp3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand add "USB/ABC4F8AA85082ED6/Music/1 经典天籁/Desert Skies - 马克西姆.姆尔维察.mp3" Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: error: updateQueue error: null Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 8ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand play Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 22ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 11ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Desert Skies","artist":"马克西姆.姆尔维察","album":"A New World","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Desert Skies - 马克西姆.姆尔维察.mp3","trackType":"mp3"} Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 25ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Desert Skies","artist":"马克西姆.姆尔维察","album":"A New World","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Desert Skies - 马克西姆.姆尔维察.mp3","trackType":"mp3"} Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 48ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioNext Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::next Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: UNSET VOLATILE Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stPlaybackTimer Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::serviceStop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::serviceStop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::play index undefined Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::startPlaybackTimer Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::clearAddPlayTracks USB/ABC4F8AA85082ED6/Music/1 经典天籁/The Piano Guys - A Sky Full of Stars.mp3 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand add "USB/ABC4F8AA85082ED6/Music/1 经典天籁/The Piano Guys - A Sky Full of Stars.mp3" Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: 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":"Desert Skies","artist":"马克西姆.姆尔维察","album":"A New World","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Desert Skies - 马克西姆.姆尔维察.mp3","trackType":"mp3"} Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: No code Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 48ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: error: updateQueue error: null Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 35ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand play Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 15ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A Sky Full of Stars","artist":"The Piano Guys","album":"A Sky Full of Stars","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/The Piano Guys - A Sky Full of Stars.mp3","trackType":"mp3"} Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 26ms Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A Sky Full of Stars","artist":"The Piano Guys","album":"A Sky Full of Stars","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/The Piano Guys - A Sky Full of Stars.mp3","trackType":"mp3"} Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:55 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 44ms Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioNext Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::next Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stop Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: UNSET VOLATILE Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stPlaybackTimer Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::serviceStop Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 4 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::serviceStop Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::stop Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::play index undefined Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::startPlaybackTimer Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::clearAddPlayTracks USB/ABC4F8AA85082ED6/Music/1 经典天籁/Leo Rojas - Colors Of The Rainbow.mp3 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand add "USB/ABC4F8AA85082ED6/Music/1 经典天籁/Leo Rojas - Colors Of The Rainbow.mp3" Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: error: updateQueue error: null Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 6ms Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand play Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 16ms Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 7ms Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Colors Of The Rainbow","artist":"Leo Rojas","album":"Albatross","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Leo Rojas - Colors Of The Rainbow.mp3","trackType":"mp3"} Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 23ms Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Colors Of The Rainbow","artist":"Leo Rojas","album":"Albatross","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Leo Rojas - Colors Of The Rainbow.mp3","trackType":"mp3"} Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:56 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 49ms Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioNext Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::next Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: UNSET VOLATILE Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::stPlaybackTimer Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::serviceStop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 5 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::serviceStop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::stop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::play index undefined Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::startPlaybackTimer Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::clearAddPlayTracks USB/ABC4F8AA85082ED6/Music/1 经典天籁/Sunquyman-Alborada_Del_Inka.mp3 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::updateTrackBlock Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrackBlock Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand add "USB/ABC4F8AA85082ED6/Music/1 经典天籁/Sunquyman-Alborada_Del_Inka.mp3" Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: 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":"Colors Of The Rainbow","artist":"Leo Rojas","album":"Albatross","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Leo Rojas - Colors Of The Rainbow.mp3","trackType":"mp3"} Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService stop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: No code Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 54ms Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: error: updateQueue error: null Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces system playlist update Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: Ignoring MPD Status Update Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 41ms Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand play Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 14ms Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: player Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Sunquyman","artist":"Alborada Del Inka","album":"Alborada Del Inka","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Sunquyman-Alborada_Del_Inka.mp3","trackType":"mp3"} Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus stop Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 26ms Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Sunquyman","artist":"Alborada Del Inka","album":"Alborada Del Inka","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Sunquyman-Alborada_Del_Inka.mp3","trackType":"mp3"} Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:49:57 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 44ms Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: update Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: Command Router : Notfying DB Updatetrue Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::Close All Modals sent Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4237,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Sunquyman","artist":"Alborada Del Inka","album":"Alborada Del Inka","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Sunquyman-Alborada_Del_Inka.mp3","trackType":"mp3"} Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 107ms Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: MPD Database updated - AlbumList cache refreshed Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: database Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: ---------------------------- MPD announces state update: update Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::getState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand status Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: Command Router : Notfying DB Updatefalse Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::Close All Modals sent Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: ControllerMpd::parseTrackInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4353,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Sunquyman","artist":"Alborada Del Inka","album":"Alborada Del Inka","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Sunquyman-Alborada_Del_Inka.mp3","trackType":"mp3"} Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ControllerMpd::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::servicePushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4353,"duration":368,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Sunquyman","artist":"Alborada Del Inka","album":"Alborada Del Inka","uri":"USB/ABC4F8AA85082ED6/Music/1 经典天籁/Sunquyman-Alborada_Del_Inka.mp3","trackType":"mp3"} Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: verbose: CURRENT POSITION 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState stateService play Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::syncState currentStatus play Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: Received an update from plugin. extracting info from payload Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreStateMachine::pushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CorePlayQueue::getTrack 6 Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::volumioPushState Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 162ms Apr 16 07:50:01 volumio-n1-sxkj volumio[22511]: info: ------------------------------ 162ms Apr 16 07:50:02 volumio-n1-sxkj volumio[22511]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 16 07:50:08 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Monogem/Wild/cd9b504c-ecdc-4230-9a7c-b99bfa88ff17.jpg' Apr 16 07:50:10 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Hans%20Zimmer/The%20Da%20Vinci%20Code/d7be7ddb-2abc-44c2-bbf6-8afe79df6659.png' Apr 16 07:50:10 volumio-n1-sxkj volumio[22511]: error: Cannot download Available plugins list: Error: ETIMEDOUT Apr 16 07:50:10 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Lenka/Trouble%20Is%20A%20Friend/7f683172-b79c-46ed-910f-d6d15a1a514a.png' Apr 16 07:50:10 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jim%20Brickman/Valentine/2394cb53-cdc4-4b6d-8cb3-120c825e3fea.jpg' Apr 16 07:50:10 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/James%20Newton%20Howard/Waterworld%20%5BOriginal%20Score%5D/fd3dcecc-546d-4399-8225-576476ce58eb.jpg' Apr 16 07:50:10 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ramin%20Djawadi/Westworld%3A%20Season%201%20(Music%20from%20the%20HBO%20Series)/32b9614f-7dd4-4fde-874e-ed208e37550f.jpg' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aschera/Whales%20Of%20Atlantis/7277749e-aaa5-4410-80e3-b37a115d404f.jpg' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Piano%20Guys/Wonders/852fe892-6c02-43f5-9ed6-9328969c158f.jpg' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20xx/xx/658a0acd-a19d-4328-8bfc-51c226b8c802.png' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yanni/Yanni%20Live%20At%20The%20Acropolis/225efbe5-6187-4d34-a67d-4d26c77b5900.png' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%9A%94%E5%A3%81%E8%80%81%E6%A8%8A/%E6%88%91%E6%9B%BE/549e9c5c-8470-42b8-99e5-f70a0d8b2710.jpg' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.E.N.S./%E6%B5%B7%E7%A5%9E/a70d07df-e828-4000-a35f-410d167d6175.jpg' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%B5%B7%E6%9D%A5%E9%98%BF%E6%9C%A8/%E7%82%B9%E6%AD%8C%E7%9A%84%E4%BA%BA/036e9043-9f38-4707-b49e-33d96e6517b5.jpg' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B5%B5%E8%81%AA/%E7%90%B5%E7%90%B6%E6%96%B0%E8%AF%AD/9b655ece-ba66-448a-86dc-3eb280584fdf.jpg' Apr 16 07:50:11 volumio-n1-sxkj volumio[22511]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%AE%B8%E5%B7%8D/%E7%AC%AC%E4%B8%89%E6%9E%81/3ac03c32-04bc-4deb-8909-d30cc5666488.jpg' Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: { Error: connect ETIMEDOUT 162.125.32.6:443 Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: at Object._errnoException (util.js:1022:11) Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: at _exceptionWithHostPort (util.js:1044:20) Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: code: 'ETIMEDOUT', Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: errno: 'ETIMEDOUT', Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: syscall: 'connect', Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: address: '162.125.32.6', Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: port: 443 } Apr 16 07:50:18 volumio-n1-sxkj volumio[22511]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 07:50:19 volumio-n1-sxkj sudo[23113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-16 07:49 Apr 16 07:50:19 volumio-n1-sxkj sudo[23113]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"