-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Wed 2025-09-10 20:12:43 CST. -- Sep 10 20:11:08 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , setBackgrounds Sep 10 20:11:08 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Sep 10 20:11:08 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 10 20:11:27 localhost volumio-remote-updater[546]: No test mode Sep 10 20:11:27 localhost volumio-remote-updater[546]: No alpha test mode Sep 10 20:11:29 localhost volumio[966]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 10 20:11:29 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 10 20:11:31 localhost volumio[966]: info: CoreCommandRouter::Close All Modals sent Sep 10 20:11:35 localhost sudo[24251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 10 20:11:35 localhost sudo[24251]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 20:11:35 localhost sudo[24253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 10 20:11:35 localhost sudo[24253]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 10 20:11:35 localhost sudo[24251]: pam_unix(sudo:session): session closed for user root Sep 10 20:11:35 localhost sudo[24253]: pam_unix(sudo:session): session closed for user root Sep 10 20:11:35 localhost volumio[966]: verbose: New Socket.io Connection to 192.168.2.106 from 192.168.2.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::volumioGetState Sep 10 20:11:35 localhost volumio[966]: info: CorePlayQueue::getTrack 6 Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::volumioGetVisibleSources Sep 10 20:11:35 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 10 20:11:36 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 10 20:11:36 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 10 20:11:36 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 10 20:11:36 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 10 20:11:36 localhost volumio[966]: info: Received Get System Version Sep 10 20:11:36 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 10 20:11:36 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Sep 10 20:11:38 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 10 20:11:38 localhost volumio[966]: info: Received Get System Info Sep 10 20:11:38 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 10 20:11:38 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 10 20:11:38 localhost volumio[966]: info: Discovery: Getting this device information Sep 10 20:11:38 localhost volumio[966]: info: CoreCommandRouter::volumioGetState Sep 10 20:11:38 localhost volumio[966]: info: CorePlayQueue::getTrack 6 Sep 10 20:11:38 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 10 20:11:41 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , setBackgrounds Sep 10 20:11:41 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Sep 10 20:11:41 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 10 20:11:44 localhost volumio[966]: info: Listing playlists Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 6 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306410] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 6 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand stop took 7 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/Lauris Reiniks - Banjo Laura.mp3 Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand stop took 2 milliseconds Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:46 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand clear took 4 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/Lauris Reiniks - Banjo Laura.mp3" Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306430] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: 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":"Closer To Me","artist":"Megan & Liz","album":"Bad for Me - EP","uri":"INTERNAL/音乐/Megan & Liz - Closer To Me.mp3","trackType":"mp3"} Sep 10 20:11:46 localhost volumio[966]: verbose: CURRENT POSITION 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306433] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: No code Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306435] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306436] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: 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} Sep 10 20:11:46 localhost volumio[966]: verbose: CURRENT POSITION 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306438] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: No code Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306439] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 33ms Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 29ms Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:46 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:46 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:46 localhost volumio[966]: error: updateQueue error: null Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:46 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand status took 30 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 29ms Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/Lauris Reiniks - Banjo Laura.mp3" took 27 milliseconds Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306457] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: 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} Sep 10 20:11:46 localhost volumio[966]: verbose: CURRENT POSITION 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306461] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: No code Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306462] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 47ms Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 31ms Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 29ms Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand play took 28 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:46 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:46 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand status took 8 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 7ms Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 5ms Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:46 localhost volumio[966]: info: Sep 10 20:11:46 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand status took 15 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand playlistinfo took 13 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand status took 13 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand status took 12 milliseconds Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":175,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Banjo Laura","artist":"Lauris Reiniks","album":"Banjo Laura","uri":"INTERNAL/音乐/Lauris Reiniks - Banjo Laura.mp3","trackType":"mp3"} Sep 10 20:11:46 localhost volumio[966]: verbose: CURRENT POSITION 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 28ms Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 10 20:11:46 localhost volumio[966]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:46 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":175,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Banjo Laura","artist":"Lauris Reiniks","album":"Banjo Laura","uri":"INTERNAL/音乐/Lauris Reiniks - Banjo Laura.mp3","trackType":"mp3"} Sep 10 20:11:46 localhost volumio[966]: verbose: CURRENT POSITION 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:46 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306522] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306525] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":175,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Banjo Laura","artist":"Lauris Reiniks","album":"Banjo Laura","uri":"INTERNAL/音乐/Lauris Reiniks - Banjo Laura.mp3","trackType":"mp3"} Sep 10 20:11:46 localhost volumio[966]: verbose: CURRENT POSITION 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:46 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306527] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306529] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":175,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Banjo Laura","artist":"Lauris Reiniks","album":"Banjo Laura","uri":"INTERNAL/音乐/Lauris Reiniks - Banjo Laura.mp3","trackType":"mp3"} Sep 10 20:11:46 localhost volumio[966]: verbose: CURRENT POSITION 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:46 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306531] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:46 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:46 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:46 localhost volumio[966]: info: [1757506306532] InterfaceMPD::pushState Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 52ms Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 50ms Sep 10 20:11:46 localhost volumio[966]: info: ------------------------------ 49ms Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307650] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 7 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand stop took 5 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3 Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand stop took 2 milliseconds Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:47 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand clear took 4 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 2 milliseconds Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3" Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307669] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: 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":"Banjo Laura","artist":"Lauris Reiniks","album":"Banjo Laura","uri":"INTERNAL/音乐/Lauris Reiniks - Banjo Laura.mp3","trackType":"mp3"} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307672] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: No code Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307673] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307675] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: 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} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307676] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: No code Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307678] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307679] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: 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} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307681] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: No code Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307682] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 37ms Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 33ms Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 33ms Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:47 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:47 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:47 localhost volumio[966]: error: updateQueue error: null Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:47 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 36ms Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3" took 35 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 4ms Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 3ms Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:47 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:47 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 17ms Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand play took 15 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 15ms Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 14ms Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 7 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 4 milliseconds Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: Sep 10 20:11:47 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 8 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱要坦荡荡","artist":"萧潇","album":"Beautiful Angel","uri":"INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3","trackType":"mp3"} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱要坦荡荡","artist":"萧潇","album":"Beautiful Angel","uri":"INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3","trackType":"mp3"} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:47 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307743] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307746] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱要坦荡荡","artist":"萧潇","album":"Beautiful Angel","uri":"INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3","trackType":"mp3"} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:47 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307748] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307750] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 35ms Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 38ms Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 38ms Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand playlistinfo took 33 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand playlistinfo took 33 milliseconds Sep 10 20:11:47 localhost volumio[966]: info: sendMpdCommand playlistinfo took 32 milliseconds Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:47 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱要坦荡荡","artist":"萧潇","album":"Beautiful Angel","uri":"INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3","trackType":"mp3"} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:47 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307771] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307774] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":238,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱要坦荡荡","artist":"萧潇","album":"Beautiful Angel","uri":"INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3","trackType":"mp3"} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:47 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307777] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307778] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":238,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱要坦荡荡","artist":"萧潇","album":"Beautiful Angel","uri":"INTERNAL/音乐/萧潇 - 爱要坦荡荡.mp3","trackType":"mp3"} Sep 10 20:11:47 localhost volumio[966]: verbose: CURRENT POSITION 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:47 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307785] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:47 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:47 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:47 localhost volumio[966]: info: [1757506307786] InterfaceMPD::pushState Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 70ms Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 67ms Sep 10 20:11:47 localhost volumio[966]: info: ------------------------------ 65ms Sep 10 20:11:47 localhost volumio[966]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%90%A7%E6%BD%87/Beautiful%20Angel/2afe8f19-24d4-42d2-8128-8a87706a9d37.png' Sep 10 20:11:49 localhost volumio[966]: info: CoreCommandRouter::volumioRandom Sep 10 20:11:49 localhost volumio[966]: info: CoreCommandRouter::writePlayerControls Sep 10 20:11:49 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:49 localhost volumio[966]: info: CoreStateMachine::setRandom true Sep 10 20:11:49 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:49 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:49 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:49 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:49 localhost volumio[966]: info: [1757506309569] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310393] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 8 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand stop took 5 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/陶喆 - 爱我还是他(Music鉴赏版).mp3 Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand stop took 2 milliseconds Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:50 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand clear took 4 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand status took 2 milliseconds Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/陶喆 - 爱我还是他(Music鉴赏版).mp3" Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310414] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: 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} Sep 10 20:11:50 localhost volumio[966]: verbose: CURRENT POSITION 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310417] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: No code Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310419] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310420] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: 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} Sep 10 20:11:50 localhost volumio[966]: verbose: CURRENT POSITION 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310422] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: No code Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310424] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 31ms Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 32ms Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:50 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:50 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:50 localhost volumio[966]: error: updateQueue error: null Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:50 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 36ms Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand playlistinfo took 34 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/陶喆 - 爱我还是他(Music鉴赏版).mp3" took 35 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 6ms Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:11:50 localhost volumio[966]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 42ms Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:50 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 14ms Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 12ms Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand play took 9 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 8ms Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:50 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand status took 6 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 4ms Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:50 localhost volumio[966]: info: Sep 10 20:11:50 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand status took 24 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand playlistinfo took 24 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand playlistinfo took 24 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand status took 23 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand status took 22 milliseconds Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱我还是他(Music鉴赏版)","artist":"陶喆","album":"太平盛世","uri":"INTERNAL/音乐/陶喆 - 爱我还是他(Music鉴赏版).mp3","trackType":"mp3"} Sep 10 20:11:50 localhost volumio[966]: verbose: CURRENT POSITION 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱我还是他(Music鉴赏版)","artist":"陶喆","album":"太平盛世","uri":"INTERNAL/音乐/陶喆 - 爱我还是他(Music鉴赏版).mp3","trackType":"mp3"} Sep 10 20:11:50 localhost volumio[966]: verbose: CURRENT POSITION 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:50 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310498] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310509] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 55ms Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 59ms Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand playlistinfo took 27 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand playlistinfo took 27 milliseconds Sep 10 20:11:50 localhost volumio[966]: info: sendMpdCommand playlistinfo took 26 milliseconds Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:50 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱我还是他(Music鉴赏版)","artist":"陶喆","album":"太平盛世","uri":"INTERNAL/音乐/陶喆 - 爱我还是他(Music鉴赏版).mp3","trackType":"mp3"} Sep 10 20:11:50 localhost volumio[966]: verbose: CURRENT POSITION 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:50 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310523] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310528] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱我还是他(Music鉴赏版)","artist":"陶喆","album":"太平盛世","uri":"INTERNAL/音乐/陶喆 - 爱我还是他(Music鉴赏版).mp3","trackType":"mp3"} Sep 10 20:11:50 localhost volumio[966]: verbose: CURRENT POSITION 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:50 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310531] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310533] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱我还是他(Music鉴赏版)","artist":"陶喆","album":"太平盛世","uri":"INTERNAL/音乐/陶喆 - 爱我还是他(Music鉴赏版).mp3","trackType":"mp3"} Sep 10 20:11:50 localhost volumio[966]: verbose: CURRENT POSITION 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:50 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310536] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:50 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:50 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:50 localhost volumio[966]: info: [1757506310538] InterfaceMPD::pushState Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 91ms Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 89ms Sep 10 20:11:50 localhost volumio[966]: info: ------------------------------ 88ms Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313156] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 130 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand stop took 6 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3 Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand stop took 1 milliseconds Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:53 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand clear took 4 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 2 milliseconds Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3" Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313176] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: 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} Sep 10 20:11:53 localhost volumio[966]: verbose: CURRENT POSITION 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313193] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: No code Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313194] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313196] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: 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} Sep 10 20:11:53 localhost volumio[966]: verbose: CURRENT POSITION 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313198] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: No code Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313200] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 39ms Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 38ms Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:53 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:53 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:53 localhost volumio[966]: error: updateQueue error: null Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:53 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 42ms Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand playlistinfo took 41 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3" took 41 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 5ms Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 4ms Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:11:53 localhost volumio[966]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 52ms Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:53 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:53 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 21ms Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand play took 18 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 15ms Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 13ms Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 8 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 9 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 7 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: Sep 10 20:11:53 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand playlistinfo took 14 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand playlistinfo took 13 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand playlistinfo took 14 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand playlistinfo took 14 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 9 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand status took 8 milliseconds Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ohlala","artist":"Mr. DA-NOS","album":"Ohlala","uri":"INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3","trackType":"mp3"} Sep 10 20:11:53 localhost volumio[966]: verbose: CURRENT POSITION 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ohlala","artist":"Mr. DA-NOS","album":"Ohlala","uri":"INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3","trackType":"mp3"} Sep 10 20:11:53 localhost volumio[966]: verbose: CURRENT POSITION 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:53 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313265] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313268] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ohlala","artist":"Mr. DA-NOS","album":"Ohlala","uri":"INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3","trackType":"mp3"} Sep 10 20:11:53 localhost volumio[966]: verbose: CURRENT POSITION 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:53 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313271] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313273] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ohlala","artist":"Mr. DA-NOS","album":"Ohlala","uri":"INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3","trackType":"mp3"} Sep 10 20:11:53 localhost volumio[966]: verbose: CURRENT POSITION 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:53 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313275] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313277] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 47ms Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 63ms Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 62ms Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 61ms Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand playlistinfo took 57 milliseconds Sep 10 20:11:53 localhost volumio[966]: info: sendMpdCommand playlistinfo took 58 milliseconds Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:53 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":182,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ohlala","artist":"Mr. DA-NOS","album":"Ohlala","uri":"INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3","trackType":"mp3"} Sep 10 20:11:53 localhost volumio[966]: verbose: CURRENT POSITION 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:53 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313323] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313327] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":182,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ohlala","artist":"Mr. DA-NOS","album":"Ohlala","uri":"INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3","trackType":"mp3"} Sep 10 20:11:53 localhost volumio[966]: verbose: CURRENT POSITION 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:53 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313329] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:53 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:53 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:53 localhost volumio[966]: info: [1757506313331] InterfaceMPD::pushState Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 89ms Sep 10 20:11:53 localhost volumio[966]: info: ------------------------------ 89ms Sep 10 20:11:54 localhost nmbd[767]: [2025/09/10 20:11:54.408512, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 10 20:11:54 localhost nmbd[767]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.2.106 for name WORKGROUP<1d>. Sep 10 20:11:54 localhost nmbd[767]: This response was from IP 192.168.2.102, reporting an IP address of 192.168.2.103. Sep 10 20:11:54 localhost nmbd[767]: [2025/09/10 20:11:54.408888, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 10 20:11:54 localhost nmbd[767]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.2.106 for name WORKGROUP<1d>. Sep 10 20:11:54 localhost nmbd[767]: This response was from IP 192.168.2.103, reporting an IP address of 192.168.2.103. Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314623] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 55 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:54 localhost nmbd[767]: [2025/09/10 20:11:54.627487, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 10 20:11:54 localhost nmbd[767]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.2.106 for name WORKGROUP<1d>. Sep 10 20:11:54 localhost nmbd[767]: This response was from IP 192.168.2.102, reporting an IP address of 192.168.2.103. Sep 10 20:11:54 localhost nmbd[767]: [2025/09/10 20:11:54.627969, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 10 20:11:54 localhost nmbd[767]: query_name_response: Multiple (5) responses received for a query on subnet 192.168.2.106 for name WORKGROUP<1d>. Sep 10 20:11:54 localhost nmbd[767]: This response was from IP 192.168.2.102, reporting an IP address of 192.168.2.103. Sep 10 20:11:54 localhost nmbd[767]: [2025/09/10 20:11:54.628298, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 10 20:11:54 localhost nmbd[767]: query_name_response: Multiple (6) responses received for a query on subnet 192.168.2.106 for name WORKGROUP<1d>. Sep 10 20:11:54 localhost nmbd[767]: This response was from IP 192.168.2.103, reporting an IP address of 192.168.2.103. Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand stop took 10 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/Nana - Dreams.mp3 Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand stop took 4 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 2 milliseconds Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:54 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand clear took 2 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/Nana - Dreams.mp3" Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314647] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: 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":"Ohlala","artist":"Mr. DA-NOS","album":"Ohlala","uri":"INTERNAL/音乐/Mr. DA-NOS - Ohlala.mp3","trackType":"mp3"} Sep 10 20:11:54 localhost volumio[966]: verbose: CURRENT POSITION 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314650] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: No code Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314651] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 10 20:11:54 localhost volumio[966]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 23ms Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 20ms Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 19ms Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:54 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:54 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:54 localhost volumio[966]: error: updateQueue error: null Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:54 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 19ms Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/Nana - Dreams.mp3" took 17 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 3ms Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 2ms Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:54 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:54 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 9ms Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand play took 7 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 5ms Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 4ms Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 10 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 8 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 4 milliseconds Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: Sep 10 20:11:54 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 7 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 4 milliseconds Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreams","artist":"Nana","album":"Father","uri":"INTERNAL/音乐/Nana - Dreams.mp3","trackType":"mp3"} Sep 10 20:11:54 localhost volumio[966]: verbose: CURRENT POSITION 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreams","artist":"Nana","album":"Father","uri":"INTERNAL/音乐/Nana - Dreams.mp3","trackType":"mp3"} Sep 10 20:11:54 localhost volumio[966]: verbose: CURRENT POSITION 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:54 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314710] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314714] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dreams","artist":"Nana","album":"Father","uri":"INTERNAL/音乐/Nana - Dreams.mp3","trackType":"mp3"} Sep 10 20:11:54 localhost volumio[966]: verbose: CURRENT POSITION 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:54 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314717] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314719] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 35ms Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 40ms Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 37ms Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand status took 30 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 26 milliseconds Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 26 milliseconds Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dreams","artist":"Nana","album":"Father","uri":"INTERNAL/音乐/Nana - Dreams.mp3","trackType":"mp3"} Sep 10 20:11:54 localhost volumio[966]: verbose: CURRENT POSITION 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:54 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314737] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314740] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dreams","artist":"Nana","album":"Father","uri":"INTERNAL/音乐/Nana - Dreams.mp3","trackType":"mp3"} Sep 10 20:11:54 localhost volumio[966]: verbose: CURRENT POSITION 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:54 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314742] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314749] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 60ms Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 58ms Sep 10 20:11:54 localhost volumio[966]: info: sendMpdCommand playlistinfo took 34 milliseconds Sep 10 20:11:54 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:54 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dreams","artist":"Nana","album":"Father","uri":"INTERNAL/音乐/Nana - Dreams.mp3","trackType":"mp3"} Sep 10 20:11:54 localhost volumio[966]: verbose: CURRENT POSITION 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:54 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314769] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:54 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:54 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:54 localhost volumio[966]: info: [1757506314773] InterfaceMPD::pushState Sep 10 20:11:54 localhost volumio[966]: info: ------------------------------ 76ms Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317272] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 32 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand stop took 6 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3 Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 6 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand stop took 5 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 2 milliseconds Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:57 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand clear took 4 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3" Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317297] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: 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":"Dreams","artist":"Nana","album":"Father","uri":"INTERNAL/音乐/Nana - Dreams.mp3","trackType":"mp3"} Sep 10 20:11:57 localhost volumio[966]: verbose: CURRENT POSITION 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317308] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: No code Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317310] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 38ms Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 34ms Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 32ms Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:57 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:57 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:57 localhost volumio[966]: error: updateQueue error: null Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:57 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 36ms Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3" took 34 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 9ms Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 7ms Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:57 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:57 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 19ms Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand play took 12 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 15ms Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 12ms Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 6 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 4 milliseconds Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: Sep 10 20:11:57 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 10 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 7 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand status took 6 milliseconds Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":168,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"极速梦想(Speed Dream)","artist":"丹戈尔","album":"热门华语184","uri":"INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3","trackType":"mp3"} Sep 10 20:11:57 localhost volumio[966]: verbose: CURRENT POSITION 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":168,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"极速梦想(Speed Dream)","artist":"丹戈尔","album":"热门华语184","uri":"INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3","trackType":"mp3"} Sep 10 20:11:57 localhost volumio[966]: verbose: CURRENT POSITION 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:57 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317368] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317371] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":168,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"极速梦想(Speed Dream)","artist":"丹戈尔","album":"热门华语184","uri":"INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3","trackType":"mp3"} Sep 10 20:11:57 localhost volumio[966]: verbose: CURRENT POSITION 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:57 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317373] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317374] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 36ms Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 35ms Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 35ms Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 34 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 34 milliseconds Sep 10 20:11:57 localhost volumio[966]: info: sendMpdCommand playlistinfo took 34 milliseconds Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":168,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"极速梦想(Speed Dream)","artist":"丹戈尔","album":"热门华语184","uri":"INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3","trackType":"mp3"} Sep 10 20:11:57 localhost volumio[966]: verbose: CURRENT POSITION 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:57 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317401] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317404] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":168,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"极速梦想(Speed Dream)","artist":"丹戈尔","album":"热门华语184","uri":"INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3","trackType":"mp3"} Sep 10 20:11:57 localhost volumio[966]: verbose: CURRENT POSITION 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:57 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317406] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317408] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":168,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"极速梦想(Speed Dream)","artist":"丹戈尔","album":"热门华语184","uri":"INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3","trackType":"mp3"} Sep 10 20:11:57 localhost volumio[966]: verbose: CURRENT POSITION 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:57 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317410] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:57 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:57 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:57 localhost volumio[966]: info: [1757506317411] InterfaceMPD::pushState Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 68ms Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 64ms Sep 10 20:11:57 localhost volumio[966]: info: ------------------------------ 64ms Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318549] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 159 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand stop took 6 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/川井憲次 - 七剑战歌.mp3 Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand stop took 2 milliseconds Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:58 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand clear took 8 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand status took 2 milliseconds Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/川井憲次 - 七剑战歌.mp3" Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318572] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: 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":"极速梦想(Speed Dream)","artist":"丹戈尔","album":"热门华语184","uri":"INTERNAL/音乐/丹戈尔 - 极速梦想(Speed Dream).mp3","trackType":"mp3"} Sep 10 20:11:58 localhost volumio[966]: verbose: CURRENT POSITION 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318575] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: No code Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318576] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318578] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: 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} Sep 10 20:11:58 localhost volumio[966]: verbose: CURRENT POSITION 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318580] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: No code Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318581] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318582] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: 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} Sep 10 20:11:58 localhost volumio[966]: verbose: CURRENT POSITION 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318584] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: No code Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318585] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 36ms Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 32ms Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 28ms Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:58 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:58 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:58 localhost volumio[966]: error: updateQueue error: null Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:58 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 31ms Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/川井憲次 - 七剑战歌.mp3" took 29 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 4ms Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 3ms Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:58 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:58 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 21ms Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand play took 19 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 18ms Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 15ms Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand status took 8 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand status took 7 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand status took 4 milliseconds Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:58 localhost volumio[966]: info: Sep 10 20:11:58 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand playlistinfo took 23 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand playlistinfo took 22 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand playlistinfo took 22 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand playlistinfo took 23 milliseconds Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand status took 21 milliseconds Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":365,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"七剑战歌","artist":"川井憲次","album":"武侠音乐系列之豪气中天","uri":"INTERNAL/音乐/川井憲次 - 七剑战歌.mp3","trackType":"mp3"} Sep 10 20:11:58 localhost volumio[966]: verbose: CURRENT POSITION 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":365,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"七剑战歌","artist":"川井憲次","album":"武侠音乐系列之豪气中天","uri":"INTERNAL/音乐/川井憲次 - 七剑战歌.mp3","trackType":"mp3"} Sep 10 20:11:58 localhost volumio[966]: verbose: CURRENT POSITION 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:58 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318657] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318663] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":365,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"七剑战歌","artist":"川井憲次","album":"武侠音乐系列之豪气中天","uri":"INTERNAL/音乐/川井憲次 - 七剑战歌.mp3","trackType":"mp3"} Sep 10 20:11:58 localhost volumio[966]: verbose: CURRENT POSITION 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:58 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318666] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318667] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":365,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"七剑战歌","artist":"川井憲次","album":"武侠音乐系列之豪气中天","uri":"INTERNAL/音乐/川井憲次 - 七剑战歌.mp3","trackType":"mp3"} Sep 10 20:11:58 localhost volumio[966]: verbose: CURRENT POSITION 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:58 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318669] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318671] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 53ms Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 60ms Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 58ms Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 57ms Sep 10 20:11:58 localhost volumio[966]: info: sendMpdCommand playlistinfo took 28 milliseconds Sep 10 20:11:58 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:58 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":365,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"七剑战歌","artist":"川井憲次","album":"武侠音乐系列之豪气中天","uri":"INTERNAL/音乐/川井憲次 - 七剑战歌.mp3","trackType":"mp3"} Sep 10 20:11:58 localhost volumio[966]: verbose: CURRENT POSITION 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:11:58 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318684] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:58 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:58 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:58 localhost volumio[966]: info: [1757506318687] InterfaceMPD::pushState Sep 10 20:11:58 localhost volumio[966]: info: ------------------------------ 59ms Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:59 localhost volumio[966]: info: [1757506319930] InterfaceMPD::pushState Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrack 154 Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand stop took 5 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3 Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand stop took 4 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand status took 2 milliseconds Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:59 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand clear took 3 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3" Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:59 localhost volumio[966]: info: [1757506319950] InterfaceMPD::pushState Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:11:59 localhost volumio[966]: 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":"武侠音乐系列之豪气中天","uri":"INTERNAL/音乐/川井憲次 - 七剑战歌.mp3","trackType":"mp3"} Sep 10 20:11:59 localhost volumio[966]: verbose: CURRENT POSITION 14 Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:59 localhost volumio[966]: info: [1757506319952] InterfaceMPD::pushState Sep 10 20:11:59 localhost volumio[966]: info: No code Sep 10 20:11:59 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:11:59 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:11:59 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:11:59 localhost volumio[966]: info: [1757506319954] InterfaceMPD::pushState Sep 10 20:11:59 localhost volumio[966]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 10 20:11:59 localhost volumio[966]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 25ms Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 23ms Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 21ms Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:59 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:59 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:59 localhost volumio[966]: error: updateQueue error: null Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:59 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 20ms Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3" took 20 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 4ms Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 3ms Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:59 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:11:59 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 12ms Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand play took 11 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 10ms Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:59 localhost volumio[966]: info: ------------------------------ 9ms Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand status took 7 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand status took 6 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:11:59 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:11:59 localhost volumio[966]: info: Sep 10 20:11:59 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:11:59 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:11:59 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:00 localhost volumio[966]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 10 20:12:00 localhost volumio[966]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 10 20:12:00 localhost volumio[966]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 10 20:12:00 localhost volumio[966]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 10 20:12:00 localhost volumio[966]: info: sendMpdCommand status took 14 milliseconds Sep 10 20:12:00 localhost volumio[966]: info: sendMpdCommand status took 11 milliseconds Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:00 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Suitcase Packed","artist":"Bodhi Jones","album":"Bones","uri":"INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3","trackType":"mp3"} Sep 10 20:12:00 localhost volumio[966]: verbose: CURRENT POSITION 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:00 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Suitcase Packed","artist":"Bodhi Jones","album":"Bones","uri":"INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3","trackType":"mp3"} Sep 10 20:12:00 localhost volumio[966]: verbose: CURRENT POSITION 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:00 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320012] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320015] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Suitcase Packed","artist":"Bodhi Jones","album":"Bones","uri":"INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3","trackType":"mp3"} Sep 10 20:12:00 localhost volumio[966]: verbose: CURRENT POSITION 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:00 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320017] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320019] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Suitcase Packed","artist":"Bodhi Jones","album":"Bones","uri":"INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3","trackType":"mp3"} Sep 10 20:12:00 localhost volumio[966]: verbose: CURRENT POSITION 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:00 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320021] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320022] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: ------------------------------ 47ms Sep 10 20:12:00 localhost volumio[966]: info: ------------------------------ 53ms Sep 10 20:12:00 localhost volumio[966]: info: ------------------------------ 51ms Sep 10 20:12:00 localhost volumio[966]: info: ------------------------------ 51ms Sep 10 20:12:00 localhost volumio[966]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bodhi%20Jones/Bones/c1f8c3a9-fda9-4954-81f5-f7f73a9daea7.jpg' Sep 10 20:12:00 localhost volumio[966]: info: sendMpdCommand playlistinfo took 26 milliseconds Sep 10 20:12:00 localhost volumio[966]: info: sendMpdCommand playlistinfo took 25 milliseconds Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:00 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:00 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Suitcase Packed","artist":"Bodhi Jones","album":"Bones","uri":"INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3","trackType":"mp3"} Sep 10 20:12:00 localhost volumio[966]: verbose: CURRENT POSITION 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:00 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320037] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320040] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Suitcase Packed","artist":"Bodhi Jones","album":"Bones","uri":"INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3","trackType":"mp3"} Sep 10 20:12:00 localhost volumio[966]: verbose: CURRENT POSITION 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:00 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320042] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:00 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:00 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:00 localhost volumio[966]: info: [1757506320044] InterfaceMPD::pushState Sep 10 20:12:00 localhost volumio[966]: info: ------------------------------ 64ms Sep 10 20:12:00 localhost volumio[966]: info: ------------------------------ 62ms Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323739] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 14 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand stop took 5 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/孙楠 - 风往北吹.mp3 Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand stop took 1 milliseconds Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:03 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand clear took 4 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand status took 2 milliseconds Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/孙楠 - 风往北吹.mp3" Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323757] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: 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":"Suitcase Packed","artist":"Bodhi Jones","album":"Bones","uri":"INTERNAL/音乐/Bodhi Jones - Suitcase Packed.mp3","trackType":"mp3"} Sep 10 20:12:03 localhost volumio[966]: verbose: CURRENT POSITION 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323760] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: No code Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323761] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323763] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: 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} Sep 10 20:12:03 localhost volumio[966]: verbose: CURRENT POSITION 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323765] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: No code Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323766] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323767] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: 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} Sep 10 20:12:03 localhost volumio[966]: verbose: CURRENT POSITION 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323769] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: No code Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323778] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 46ms Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 42ms Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 43ms Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:03 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:03 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:03 localhost volumio[966]: error: updateQueue error: null Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:03 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 45ms Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/孙楠 - 风往北吹.mp3" took 43 milliseconds Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 20ms Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 19ms Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand play took 18 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:03 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:03 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand status took 7 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 7ms Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 6ms Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:03 localhost volumio[966]: info: Sep 10 20:12:03 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand status took 45 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand playlistinfo took 44 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand status took 43 milliseconds Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand status took 41 milliseconds Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"风往北吹","artist":"孙楠","album":"南极光","uri":"INTERNAL/音乐/孙楠 - 风往北吹.mp3","trackType":"mp3"} Sep 10 20:12:03 localhost volumio[966]: verbose: CURRENT POSITION 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 59ms Sep 10 20:12:03 localhost volumio[966]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 10 20:12:03 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"风往北吹","artist":"孙楠","album":"南极光","uri":"INTERNAL/音乐/孙楠 - 风往北吹.mp3","trackType":"mp3"} Sep 10 20:12:03 localhost volumio[966]: verbose: CURRENT POSITION 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:03 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323883] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323887] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"风往北吹","artist":"孙楠","album":"南极光","uri":"INTERNAL/音乐/孙楠 - 风往北吹.mp3","trackType":"mp3"} Sep 10 20:12:03 localhost volumio[966]: verbose: CURRENT POSITION 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:03 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323890] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323891] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":293,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"风往北吹","artist":"孙楠","album":"南极光","uri":"INTERNAL/音乐/孙楠 - 风往北吹.mp3","trackType":"mp3"} Sep 10 20:12:03 localhost volumio[966]: verbose: CURRENT POSITION 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:03 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323895] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:03 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:03 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:03 localhost volumio[966]: info: [1757506323896] InterfaceMPD::pushState Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 86ms Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 89ms Sep 10 20:12:03 localhost volumio[966]: info: ------------------------------ 89ms Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioNext Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::next Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::stop Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::stPlaybackTimer Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326233] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::serviceStop Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 122 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::serviceStop Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::stop Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand stop took 8 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::play index undefined Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::startPlaybackTimer Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3 Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand stop Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::updateTrackBlock Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrackBlock Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 3 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand stop took 2 milliseconds Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand clear Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:06 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand clear took 6 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 4 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 4 milliseconds Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3" Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326259] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: 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":"南极光","uri":"INTERNAL/音乐/孙楠 - 风往北吹.mp3","trackType":"mp3"} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326262] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: No code Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326264] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326269] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: 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} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326270] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: No code Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326272] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326273] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: 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} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService stop Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326275] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: No code Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326276] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 42ms Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 37ms Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 35ms Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:06 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:06 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:06 localhost volumio[966]: error: updateQueue error: null Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:06 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 38ms Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand add "INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3" took 35 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 4ms Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 3ms Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand play Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:06 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces system playlist update Sep 10 20:12:06 localhost volumio[966]: info: Ignoring MPD Status Update Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 20ms Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand play took 18 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 19ms Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 17ms Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 6 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 6 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 4 milliseconds Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: Sep 10 20:12:06 localhost volumio[966]: ---------------------------- MPD announces state update: player Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::getState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand status Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 6 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand status took 5 milliseconds Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseState Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你曾是少年","artist":"焦迈奇","album":"你曾是少年","uri":"INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3","trackType":"mp3"} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus stop Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你曾是少年","artist":"焦迈奇","album":"你曾是少年","uri":"INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3","trackType":"mp3"} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:06 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326333] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326336] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你曾是少年","artist":"焦迈奇","album":"你曾是少年","uri":"INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3","trackType":"mp3"} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:06 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326338] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326340] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你曾是少年","artist":"焦迈奇","album":"你曾是少年","uri":"INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3","trackType":"mp3"} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:06 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326342] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326343] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 34ms Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 39ms Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 38ms Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 38ms Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand playlistinfo took 53 milliseconds Sep 10 20:12:06 localhost volumio[966]: info: sendMpdCommand playlistinfo took 52 milliseconds Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:06 localhost volumio[966]: verbose: ControllerMpd::parseTrackInfo Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"你曾是少年","artist":"焦迈奇","album":"你曾是少年","uri":"INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3","trackType":"mp3"} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:06 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326385] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326388] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: ControllerMpd::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::servicePushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"你曾是少年","artist":"焦迈奇","album":"你曾是少年","uri":"INTERNAL/音乐/焦迈奇 - 你曾是少年.mp3","trackType":"mp3"} Sep 10 20:12:06 localhost volumio[966]: verbose: CURRENT POSITION 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState stateService play Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::syncState currentStatus play Sep 10 20:12:06 localhost volumio[966]: info: Received an update from plugin. extracting info from payload Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326390] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: CoreStateMachine::pushState Sep 10 20:12:06 localhost volumio[966]: info: CorePlayQueue::getTrack 108 Sep 10 20:12:06 localhost volumio[966]: info: CoreCommandRouter::volumioPushState Sep 10 20:12:06 localhost volumio[966]: info: [1757506326392] InterfaceMPD::pushState Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 76ms Sep 10 20:12:06 localhost volumio[966]: info: ------------------------------ 75ms Sep 10 20:12:43 localhost volumio[966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 10 20:12:43 localhost volumio[966]: Error: connect ETIMEDOUT 128.121.146.228:443 Sep 10 20:12:43 localhost volumio[966]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Sep 10 20:12:43 localhost volumio[966]: errno: -110, Sep 10 20:12:43 localhost volumio[966]: code: 'ETIMEDOUT', Sep 10 20:12:43 localhost volumio[966]: syscall: 'connect', Sep 10 20:12:43 localhost volumio[966]: address: '128.121.146.228', Sep 10 20:12:43 localhost volumio[966]: port: 443 Sep 10 20:12:43 localhost volumio[966]: } Sep 10 20:12:43 localhost volumio[966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 10 20:12:43 localhost sudo[25154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-10 20:11 Sep 10 20:12:43 localhost sudo[25154]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"