-- Logs begin at Thu 2025-07-03 05:59:07 UTC, end at Thu 2025-07-03 10:05:55 UTC. -- Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:09 volumion1 volumio[19238]: info: Jul 03 10:04:09 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:09 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:09 volumion1 volumio[19238]: info: Jul 03 10:04:09 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:09 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:09 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:09 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:09 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:09 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":247478,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:04:09 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:09 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:09 volumion1 volumio[19238]: info: ------------------------------ 83ms Jul 03 10:04:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:09 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:09 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":247478,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:04:09 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:09 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:09 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:09 volumion1 volumio[19238]: info: ------------------------------ 117ms Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:20 volumion1 volumio[19238]: info: Jul 03 10:04:20 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:20 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:20 volumion1 volumio[19238]: info: Jul 03 10:04:20 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:20 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:20 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:20 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:20 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:20 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":258484,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:04:20 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:20 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:20 volumion1 volumio[19238]: info: ------------------------------ 86ms Jul 03 10:04:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:20 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:20 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":258484,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:04:20 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:20 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:20 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:20 volumion1 volumio[19238]: info: ------------------------------ 114ms Jul 03 10:04:24 volumion1 sudo[19967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 03 10:04:24 volumion1 sudo[19967]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 03 10:04:24 volumion1 sudo[19967]: pam_unix(sudo:session): session closed for user root Jul 03 10:04:24 volumion1 sudo[19969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 03 10:04:24 volumion1 sudo[19969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 03 10:04:24 volumion1 sudo[19969]: pam_unix(sudo:session): session closed for user root Jul 03 10:04:25 volumion1 volumio[19238]: info: CoreCommandRouter::volumioGetState Jul 03 10:04:25 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:25 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 03 10:04:25 volumion1 volumio[19238]: info: Listing playlists Jul 03 10:04:25 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 03 10:04:25 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 03 10:04:25 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 03 10:04:25 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 03 10:04:26 volumion1 volumio[19238]: info: CoreCommandRouter::volumioGetVisibleSources Jul 03 10:04:26 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 03 10:04:26 volumion1 volumio[19238]: info: CoreCommandRouter::volumioGetState Jul 03 10:04:26 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:26 volumion1 volumio[19238]: info: CoreCommandRouter::volumioGetQueue Jul 03 10:04:26 volumion1 volumio[19238]: info: CoreStateMachine::getQueue Jul 03 10:04:26 volumion1 volumio[19238]: info: CorePlayQueue::getQueue Jul 03 10:04:26 volumion1 volumio[19238]: info: Listing playlists Jul 03 10:04:26 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 03 10:04:28 volumion1 volumio[19238]: info: CoreCommandRouter::volumioGetQueue Jul 03 10:04:28 volumion1 volumio[19238]: info: CoreStateMachine::getQueue Jul 03 10:04:28 volumion1 volumio[19238]: info: CorePlayQueue::getQueue Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:29 volumion1 volumio[19238]: info: Jul 03 10:04:29 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:29 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:29 volumion1 volumio[19238]: info: Jul 03 10:04:29 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:29 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:29 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:29 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:29 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:29 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":267493,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:04:29 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:29 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:29 volumion1 volumio[19238]: info: ------------------------------ 97ms Jul 03 10:04:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:29 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:29 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":267493,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:04:29 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:29 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:29 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:29 volumion1 volumio[19238]: info: ------------------------------ 133ms Jul 03 10:04:33 volumion1 volumio[19238]: info: Jul 03 10:04:33 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:33 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:33 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:33 volumion1 volumio[19238]: 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 03 10:04:33 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService stop Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::play index undefined Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/09 - Can’t Stop Love.mp3 Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:33 volumion1 volumio[19238]: info: ------------------------------ 35ms Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 10:04:33 volumion1 volumio[19238]: info: Jul 03 10:04:33 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:33 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/09 - Can’t Stop Love.mp3" Jul 03 10:04:33 volumion1 volumio[19238]: error: updateQueue error: null Jul 03 10:04:33 volumion1 volumio[19238]: info: Jul 03 10:04:33 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:33 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:33 volumion1 volumio[19238]: info: ------------------------------ 7ms Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand play Jul 03 10:04:33 volumion1 volumio[19238]: info: ------------------------------ 10ms Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: Prefetching next song Jul 03 10:04:33 volumion1 volumio[19238]: info: DOING PREFETCH IN MPD Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/19 - 粉雪につつまれて.mp3" Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: Jul 03 10:04:33 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:33 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 03 10:04:33 volumion1 volumio[19238]: info: Jul 03 10:04:33 volumion1 volumio[19238]: ---------------------------- MPD announces state update: options Jul 03 10:04:33 volumion1 volumio[19238]: info: ------------------------------ 5ms Jul 03 10:04:33 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"09 - Can’t Stop Love.mp3","artist":null,"album":null,"uri":"USB/MUSIC/09 - Can’t Stop Love.mp3","trackType":"mp3"} Jul 03 10:04:33 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: ------------------------------ 21ms Jul 03 10:04:33 volumion1 volumio[19238]: info: Jul 03 10:04:33 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:33 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:33 volumion1 volumio[19238]: info: ------------------------------ 3ms Jul 03 10:04:33 volumion1 volumio[19238]: info: Jul 03 10:04:33 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:33 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:33 volumion1 volumio[19238]: info: Jul 03 10:04:33 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:33 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:33 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:33 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: ------------------------------ 35ms Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:33 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:33 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:33 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:33 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:33 volumion1 volumio[19238]: info: ------------------------------ 60ms Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPrevious Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::previous Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: ControllerMpd::seek Jul 03 10:04:38 volumion1 volumio[19238]: error: null Jul 03 10:04:38 volumion1 volumio[19238]: info: Jul 03 10:04:38 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:38 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:38 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:38 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: ------------------------------ 28ms Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:38 volumion1 volumio[19238]: info: Jul 03 10:04:38 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:38 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:38 volumion1 volumio[19238]: info: Jul 03 10:04:38 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:38 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:38 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:38 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":313,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:38 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:38 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: ------------------------------ 91ms Jul 03 10:04:38 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":313,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:38 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:38 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:38 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:38 volumion1 volumio[19238]: info: ------------------------------ 120ms Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPrevious Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::previous Jul 03 10:04:39 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::stop Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:39 volumion1 volumio[19238]: UNSET VOLATILE Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::stPlaybackTimer Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::updateTrackBlock Jul 03 10:04:39 volumion1 volumio[19238]: info: CorePlayQueue::getTrackBlock Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::serviceStop Jul 03 10:04:39 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::serviceStop Jul 03 10:04:39 volumion1 volumio[19238]: info: ControllerMpd::stop Jul 03 10:04:39 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:39 volumion1 volumio[19238]: info: Jul 03 10:04:39 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:39 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:39 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:39 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:39 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:39 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:39 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:39 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:39 volumion1 volumio[19238]: 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":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:39 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService stop Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:39 volumion1 volumio[19238]: info: No code Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:39 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:39 volumion1 volumio[19238]: info: ------------------------------ 33ms Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::play index undefined Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/09 - Can’t Stop Love.mp3 Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 10:04:40 volumion1 volumio[19238]: info: Jul 03 10:04:40 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:40 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/09 - Can’t Stop Love.mp3" Jul 03 10:04:40 volumion1 volumio[19238]: error: updateQueue error: null Jul 03 10:04:40 volumion1 volumio[19238]: info: Jul 03 10:04:40 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:40 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:40 volumion1 volumio[19238]: info: ------------------------------ 5ms Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand play Jul 03 10:04:40 volumion1 volumio[19238]: info: ------------------------------ 13ms Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:40 volumion1 volumio[19238]: info: Prefetching next song Jul 03 10:04:40 volumion1 volumio[19238]: info: DOING PREFETCH IN MPD Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/19 - 粉雪につつまれて.mp3" Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:40 volumion1 volumio[19238]: info: Jul 03 10:04:40 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:40 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 03 10:04:40 volumion1 volumio[19238]: info: ------------------------------ 4ms Jul 03 10:04:40 volumion1 volumio[19238]: info: Jul 03 10:04:40 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:40 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:40 volumion1 volumio[19238]: info: ------------------------------ 2ms Jul 03 10:04:40 volumion1 volumio[19238]: info: Jul 03 10:04:40 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:40 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:40 volumion1 volumio[19238]: info: Jul 03 10:04:40 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:40 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:40 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:40 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:40 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:40 volumion1 volumio[19238]: info: ------------------------------ 28ms Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:40 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:40 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:40 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:40 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:40 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:40 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:40 volumion1 volumio[19238]: info: ------------------------------ 50ms Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPrevious Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreStateMachine::previous Jul 03 10:04:41 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:41 volumion1 volumio[19238]: info: ControllerMpd::seek Jul 03 10:04:41 volumion1 volumio[19238]: error: null Jul 03 10:04:41 volumion1 volumio[19238]: info: Jul 03 10:04:41 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:41 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:41 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:41 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:41 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:41 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:41 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:41 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:41 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:41 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:41 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:41 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:41 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:41 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:41 volumion1 volumio[19238]: info: ------------------------------ 32ms Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPrevious Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::previous Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::stop Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:42 volumion1 volumio[19238]: UNSET VOLATILE Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::stPlaybackTimer Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::updateTrackBlock Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrackBlock Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::serviceStop Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::serviceStop Jul 03 10:04:42 volumion1 volumio[19238]: info: ControllerMpd::stop Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:42 volumion1 volumio[19238]: info: Jul 03 10:04:42 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:42 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:42 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: 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":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:42 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService stop Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:42 volumion1 volumio[19238]: info: No code Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:42 volumion1 volumio[19238]: info: ------------------------------ 41ms Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::play index undefined Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/09 - Can’t Stop Love.mp3 Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 10:04:42 volumion1 volumio[19238]: info: Jul 03 10:04:42 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:42 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/09 - Can’t Stop Love.mp3" Jul 03 10:04:42 volumion1 volumio[19238]: error: updateQueue error: null Jul 03 10:04:42 volumion1 volumio[19238]: info: Jul 03 10:04:42 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:42 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:42 volumion1 volumio[19238]: info: ------------------------------ 6ms Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand play Jul 03 10:04:42 volumion1 volumio[19238]: info: ------------------------------ 10ms Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: Prefetching next song Jul 03 10:04:42 volumion1 volumio[19238]: info: DOING PREFETCH IN MPD Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/19 - 粉雪につつまれて.mp3" Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: Jul 03 10:04:42 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:42 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 03 10:04:42 volumion1 volumio[19238]: info: ------------------------------ 3ms Jul 03 10:04:42 volumion1 volumio[19238]: info: Jul 03 10:04:42 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:42 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:42 volumion1 volumio[19238]: info: ------------------------------ 2ms Jul 03 10:04:42 volumion1 volumio[19238]: info: Jul 03 10:04:42 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:42 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:42 volumion1 volumio[19238]: info: Jul 03 10:04:42 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:42 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:42 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:42 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:42 volumion1 volumio[19238]: info: ------------------------------ 26ms Jul 03 10:04:42 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:42 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:42 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:42 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:42 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:42 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:43 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: ------------------------------ 46ms Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPrevious Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::previous Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::stop Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:43 volumion1 volumio[19238]: UNSET VOLATILE Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::stPlaybackTimer Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::updateTrackBlock Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrackBlock Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::serviceStop Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::serviceStop Jul 03 10:04:43 volumion1 volumio[19238]: info: ControllerMpd::stop Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:43 volumion1 volumio[19238]: info: Jul 03 10:04:43 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:43 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: 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":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:43 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService stop Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: No code Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: ------------------------------ 40ms Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPrevious Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::previous Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::updateTrackBlock Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrackBlock Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::play index undefined Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/02 - Lady.mp3 Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 10:04:43 volumion1 volumio[19238]: info: Jul 03 10:04:43 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:43 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/02 - Lady.mp3" Jul 03 10:04:43 volumion1 volumio[19238]: error: updateQueue error: null Jul 03 10:04:43 volumion1 volumio[19238]: info: Jul 03 10:04:43 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:43 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:43 volumion1 volumio[19238]: info: ------------------------------ 5ms Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand play Jul 03 10:04:43 volumion1 volumio[19238]: info: ------------------------------ 4ms Jul 03 10:04:43 volumion1 volumio[19238]: info: Jul 03 10:04:43 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:43 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:43 volumion1 volumio[19238]: info: Jul 03 10:04:43 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:43 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:43 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":233,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"02 - Lady.mp3","artist":null,"album":null,"uri":"USB/MUSIC/02 - Lady.mp3","trackType":"mp3"} Jul 03 10:04:43 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: ------------------------------ 38ms Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:43 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:43 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":233,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"02 - Lady.mp3","artist":null,"album":null,"uri":"USB/MUSIC/02 - Lady.mp3","trackType":"mp3"} Jul 03 10:04:43 volumion1 volumio[19238]: verbose: CURRENT POSITION 0 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:43 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:43 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:43 volumion1 volumio[19238]: info: ------------------------------ 54ms Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::volumioNext Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::next Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::stop Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:45 volumion1 volumio[19238]: UNSET VOLATILE Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::stPlaybackTimer Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::updateTrackBlock Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrackBlock Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::serviceStop Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 0 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::serviceStop Jul 03 10:04:45 volumion1 volumio[19238]: info: ControllerMpd::stop Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:45 volumion1 volumio[19238]: info: Jul 03 10:04:45 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:45 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::play index undefined Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/09 - Can’t Stop Love.mp3 Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::updateTrackBlock Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrackBlock Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 10:04:45 volumion1 volumio[19238]: info: Jul 03 10:04:45 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:45 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/09 - Can’t Stop Love.mp3" Jul 03 10:04:45 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:45 volumion1 volumio[19238]: 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":"02 - Lady.mp3","artist":null,"album":null,"uri":"USB/MUSIC/02 - Lady.mp3","trackType":"mp3"} Jul 03 10:04:45 volumion1 volumio[19238]: verbose: CURRENT POSITION 1 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService stop Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: No code Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: ------------------------------ 56ms Jul 03 10:04:45 volumion1 volumio[19238]: error: updateQueue error: null Jul 03 10:04:45 volumion1 volumio[19238]: info: Jul 03 10:04:45 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:45 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:45 volumion1 volumio[19238]: info: ------------------------------ 46ms Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand play Jul 03 10:04:45 volumion1 volumio[19238]: info: ------------------------------ 20ms Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 1 Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:45 volumion1 volumio[19238]: info: Prefetching next song Jul 03 10:04:45 volumion1 volumio[19238]: info: DOING PREFETCH IN MPD Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/19 - 粉雪につつまれて.mp3" Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:45 volumion1 volumio[19238]: info: Jul 03 10:04:45 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:45 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 03 10:04:45 volumion1 volumio[19238]: info: ------------------------------ 5ms Jul 03 10:04:45 volumion1 volumio[19238]: info: Jul 03 10:04:45 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:04:45 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:04:45 volumion1 volumio[19238]: info: ------------------------------ 3ms Jul 03 10:04:45 volumion1 volumio[19238]: info: Jul 03 10:04:45 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:45 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:45 volumion1 volumio[19238]: info: Jul 03 10:04:45 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:04:45 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:45 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:45 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: ------------------------------ 28ms Jul 03 10:04:45 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:45 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:45 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:45 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:45 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:45 volumion1 volumio[19238]: info: ------------------------------ 51ms Jul 03 10:04:45 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Offspring/Americana/4a7c8af5-34df-40c9-ae61-2661c9366b52.jpg' Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:49 volumion1 volumio[19238]: info: Jul 03 10:04:49 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:49 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:49 volumion1 volumio[19238]: info: Jul 03 10:04:49 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:04:49 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:49 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:49 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:49 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:49 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4353,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:49 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:49 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:49 volumion1 volumio[19238]: info: ------------------------------ 92ms Jul 03 10:04:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:04:49 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:49 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4353,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"粉雪につつまれて","artist":"日本动漫","album":"「AS DVD 生まれたばかりのLove Song」オリジナルサウンドトラック","uri":"USB/MUSIC/19 - 粉雪につつまれて.mp3","trackType":"mp3"} Jul 03 10:04:49 volumion1 volumio[19238]: verbose: CURRENT POSITION 2 Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:04:49 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:04:49 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:04:49 volumion1 volumio[19238]: info: ------------------------------ 118ms Jul 03 10:04:51 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jaymay/Autumn%20Fallin%27/17a9f889-6b06-48fa-aa88-f29e6272d387.jpg' Jul 03 10:04:51 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%90%A7%E8%90%A7/Beautiful%20Angel/c95ed5fa-fdd3-438c-a6b6-e9510567ef4b.jpg' Jul 03 10:04:51 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ayur/Beautiful%20Field/66e102ad-596b-46ae-84ad-a9b097fd2eef.jpg' Jul 03 10:04:51 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jesse%20McCartney/Beautiful%20Soul/0e5ee4a5-4421-4e6a-a2f7-45815f9295b1.jpg' Jul 03 10:04:51 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Go%20Back%20To%20the%20Zoo/Benny%20Blisto/8013d1f4-d226-4eed-b065-16d3f469fad3.jpg' Jul 03 10:04:51 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Plain%20White%20T%27s/Big%20Bad%20World/11becd11-527c-4a29-a135-0364d394ad0c.jpg' Jul 03 10:04:52 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joni%20Mitchell/Blue/e0ab47f4-a803-4534-bb61-6590e9642514.jpg' Jul 03 10:04:56 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Cranberries/Bury%20the%20Hatchet/a1497950-1ff7-4f51-bcac-d42335674e96.jpg' Jul 03 10:04:56 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Black%20Keys/Brothers/42f8a455-ffc9-480c-b4f6-e95e5ac12111.jpg' Jul 03 10:04:56 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%97%A4%E7%94%B0%E6%81%B5%E7%BE%8E/Camomile%20Classics/1555fb0e-aba6-4fab-9125-ca62a916d6ab.jpg' Jul 03 10:04:56 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/YUI/Can%27t%20Buy%20My%20Love/d5ebda8c-bf17-46ea-a651-eaf31c6055d6.png' Jul 03 10:04:56 volumion1 volumio[19238]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Laura%20Fygi/Change/7a49deaa-bb94-43a4-b952-de98951c8955.jpg' Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPlay Jul 03 10:05:01 volumion1 volumio[19238]: UNSET VOLATILE Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::play index 722 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::stop Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:05:01 volumion1 volumio[19238]: UNSET VOLATILE Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::stPlaybackTimer Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::updateTrackBlock Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrackBlock Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::serviceStop Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 2 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::serviceStop Jul 03 10:05:01 volumion1 volumio[19238]: info: ControllerMpd::stop Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::play index undefined Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::startPlaybackTimer Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/一生所爱/Track01.WAV Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 10:05:01 volumion1 volumio[19238]: info: Jul 03 10:05:01 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:05:01 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 10:05:01 volumion1 volumio[19238]: info: Jul 03 10:05:01 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:05:01 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/一生所爱/Track01.WAV" Jul 03 10:05:01 volumion1 volumio[19238]: error: updateQueue error: null Jul 03 10:05:01 volumion1 volumio[19238]: info: Jul 03 10:05:01 volumion1 volumio[19238]: ---------------------------- MPD announces system playlist update Jul 03 10:05:01 volumion1 volumio[19238]: info: Ignoring MPD Status Update Jul 03 10:05:01 volumion1 volumio[19238]: info: ------------------------------ 6ms Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand play Jul 03 10:05:01 volumion1 volumio[19238]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 03 10:05:01 volumion1 volumio[19238]: info: ------------------------------ 15ms Jul 03 10:05:01 volumion1 volumio[19238]: info: ------------------------------ 6ms Jul 03 10:05:01 volumion1 volumio[19238]: info: Jul 03 10:05:01 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:05:01 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:01 volumion1 volumio[19238]: info: Jul 03 10:05:01 volumion1 volumio[19238]: ---------------------------- MPD announces state update: player Jul 03 10:05:01 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:01 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:01 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:01 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus stop Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:01 volumion1 volumio[19238]: info: ------------------------------ 26ms Jul 03 10:05:01 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:01 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:01 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:01 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:01 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:01 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:01 volumion1 volumio[19238]: info: ------------------------------ 39ms Jul 03 10:05:02 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:03 volumion1 volumio[19238]: info: Jul 03 10:05:03 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:03 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:03 volumion1 volumio[19238]: info: Jul 03 10:05:03 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:03 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:03 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:03 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:03 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:03 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1718,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:03 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:03 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:03 volumion1 volumio[19238]: info: ------------------------------ 100ms Jul 03 10:05:03 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:03 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:03 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1718,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:03 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:03 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:03 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:03 volumion1 volumio[19238]: info: ------------------------------ 132ms Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:09 volumion1 volumio[19238]: info: Jul 03 10:05:09 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:09 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:09 volumion1 volumio[19238]: info: Jul 03 10:05:09 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:09 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:09 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:09 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:09 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:09 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8080,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:09 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:09 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:09 volumion1 volumio[19238]: info: ------------------------------ 90ms Jul 03 10:05:09 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:09 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:09 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8080,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:09 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:09 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:09 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:09 volumion1 volumio[19238]: info: ------------------------------ 115ms Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:20 volumion1 volumio[19238]: info: Jul 03 10:05:20 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:20 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:20 volumion1 volumio[19238]: info: Jul 03 10:05:20 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:20 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:20 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:20 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:20 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:20 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19226,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:20 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:20 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:20 volumion1 volumio[19238]: info: ------------------------------ 83ms Jul 03 10:05:20 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:20 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:20 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19226,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:20 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:20 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:20 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:20 volumion1 volumio[19238]: info: ------------------------------ 126ms Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:29 volumion1 volumio[19238]: info: Jul 03 10:05:29 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:29 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:29 volumion1 volumio[19238]: info: Jul 03 10:05:29 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:29 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:29 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:29 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:29 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:29 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28212,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:29 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:29 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:29 volumion1 volumio[19238]: info: ------------------------------ 84ms Jul 03 10:05:29 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:29 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:29 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28212,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:29 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:29 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:29 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:29 volumion1 volumio[19238]: info: ------------------------------ 109ms Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:49 volumion1 volumio[19238]: info: Jul 03 10:05:49 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:49 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:49 volumion1 volumio[19238]: info: Jul 03 10:05:49 volumion1 volumio[19238]: ---------------------------- MPD announces state update: update Jul 03 10:05:49 volumion1 volumio[19238]: info: ControllerMpd::getState Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand status Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:49 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:49 volumion1 volumio[19238]: info: Command Router : Notfying DB Updatefalse Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::Close All Modals sent Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseState Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:49 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:49 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48227,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:49 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:49 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:49 volumion1 volumio[19238]: info: ------------------------------ 89ms Jul 03 10:05:49 volumion1 volumio[19238]: verbose: ControllerMpd::parseTrackInfo Jul 03 10:05:49 volumion1 volumio[19238]: info: ControllerMpd::pushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::servicePushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:49 volumion1 volumio[19238]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48227,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01.WAV","artist":null,"album":null,"uri":"USB/MUSIC/一生所爱/Track01.WAV","trackType":"WAV"} Jul 03 10:05:49 volumion1 volumio[19238]: verbose: CURRENT POSITION 722 Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreStateMachine::syncState stateService play Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreStateMachine::syncState currentStatus play Jul 03 10:05:49 volumion1 volumio[19238]: info: Received an update from plugin. extracting info from payload Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreStateMachine::pushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CorePlayQueue::getTrack 722 Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::volumioPushState Jul 03 10:05:49 volumion1 volumio[19238]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 10:05:49 volumion1 volumio[19238]: info: ------------------------------ 113ms Jul 03 10:05:55 volumion1 volumio[19238]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 03 10:05:55 volumion1 volumio[19238]: { Error: connect ETIMEDOUT 128.242.240.157:443 Jul 03 10:05:55 volumion1 volumio[19238]: at Object._errnoException (util.js:1022:11) Jul 03 10:05:55 volumion1 volumio[19238]: at _exceptionWithHostPort (util.js:1044:20) Jul 03 10:05:55 volumion1 volumio[19238]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 03 10:05:55 volumion1 volumio[19238]: code: 'ETIMEDOUT', Jul 03 10:05:55 volumion1 volumio[19238]: errno: 'ETIMEDOUT', Jul 03 10:05:55 volumion1 volumio[19238]: syscall: 'connect', Jul 03 10:05:55 volumion1 volumio[19238]: address: '128.242.240.157', Jul 03 10:05:55 volumion1 volumio[19238]: port: 443 } Jul 03 10:05:55 volumion1 volumio[19238]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 03 10:05:55 volumion1 sudo[20308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-03 10:04 Jul 03 10:05:55 volumion1 sudo[20308]: 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"