-- Logs begin at Fri 2024-11-01 09:05:41 CST, end at Fri 2024-11-01 09:43:47 CST. -- Nov 01 09:42:08 volumioliu sudo[6230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 09:42:08 volumioliu sudo[6230]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:42:08 volumioliu sudo[6230]: pam_unix(sudo:session): session closed for user root Nov 01 09:42:08 volumioliu sudo[6233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 09:42:08 volumioliu sudo[6233]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:42:08 volumioliu sudo[6233]: pam_unix(sudo:session): session closed for user root Nov 01 09:42:08 volumioliu volumio[3494]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.101 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:08 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 09:42:08 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:08 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:08 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:08 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:08 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetQueue Nov 01 09:42:08 volumioliu volumio[3494]: info: CoreStateMachine::getQueue Nov 01 09:42:08 volumioliu volumio[3494]: info: CorePlayQueue::getQueue Nov 01 09:42:09 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:09 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:09 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:09 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:09 volumioliu sudo[6237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 09:42:09 volumioliu sudo[6237]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:42:09 volumioliu sudo[6237]: pam_unix(sudo:session): session closed for user root Nov 01 09:42:09 volumioliu sudo[6238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 09:42:09 volumioliu sudo[6238]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:42:09 volumioliu sudo[6238]: pam_unix(sudo:session): session closed for user root Nov 01 09:42:09 volumioliu volumio[3494]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.101 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:09 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 09:42:09 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:09 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:09 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:09 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:09 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetQueue Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreStateMachine::getQueue Nov 01 09:42:09 volumioliu volumio[3494]: info: CorePlayQueue::getQueue Nov 01 09:42:09 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:09 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:09 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:09 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:09 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:13 volumioliu sudo[6253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 09:42:13 volumioliu sudo[6253]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:42:13 volumioliu sudo[6253]: pam_unix(sudo:session): session closed for user root Nov 01 09:42:13 volumioliu sudo[6256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 09:42:13 volumioliu sudo[6256]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:42:13 volumioliu sudo[6256]: pam_unix(sudo:session): session closed for user root Nov 01 09:42:13 volumioliu volumio[3494]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.101 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:13 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 09:42:13 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:13 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:13 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:13 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:13 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetQueue Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreStateMachine::getQueue Nov 01 09:42:13 volumioliu volumio[3494]: info: CorePlayQueue::getQueue Nov 01 09:42:13 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:13 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:13 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:13 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:13 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:13 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:13 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:13 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:13 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::volumioNext Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::next Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 35 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:18 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:18 volumioliu volumio[3494]: info: Nov 01 09:42:18 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand stop took 28 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/男儿当自强.dsf Nov 01 09:42:18 volumioliu volumio[3494]: info: Setting Volume to 100 automatically for DSD Nov 01 09:42:18 volumioliu volumio[3494]: info: VolumeController::SetAlsaVolume100 Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand status took 38 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand stop took 13 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:18 volumioliu volumio[3494]: info: Nov 01 09:42:18 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:18 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand clear took 14 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/男儿当自强.dsf" Nov 01 09:42:18 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: 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":"YouAreNotAlone.flac","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/YouAreNotAlone.flac","trackType":"flac"} Nov 01 09:42:18 volumioliu volumio[3494]: verbose: CURRENT POSITION 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:18 volumioliu volumio[3494]: info: No code Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:18 volumioliu volumio[3494]: info: ------------------------------ 78ms Nov 01 09:42:18 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:18 volumioliu volumio[3494]: info: Nov 01 09:42:18 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:18 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:18 volumioliu volumio[3494]: info: ------------------------------ 29ms Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/男儿当自强.dsf" took 26 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:18 volumioliu volumio[3494]: info: Nov 01 09:42:18 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:18 volumioliu volumio[3494]: info: ------------------------------ 8ms Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand play took 6 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:18 volumioliu volumio[3494]: info: Nov 01 09:42:18 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:18 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand status took 4 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand status took 67 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 66 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:18 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":259,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"男儿当自强.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/男儿当自强.dsf","trackType":"dsf"} Nov 01 09:42:18 volumioliu volumio[3494]: verbose: CURRENT POSITION 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:18 volumioliu volumio[3494]: info: ------------------------------ 74ms Nov 01 09:42:18 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 01 09:42:18 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:18 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":259,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"男儿当自强.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/男儿当自强.dsf","trackType":"dsf"} Nov 01 09:42:18 volumioliu volumio[3494]: verbose: CURRENT POSITION 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:18 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:18 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:18 volumioliu volumio[3494]: info: ------------------------------ 83ms Nov 01 09:42:18 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 09:42:19 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::volumioNext Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::next Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 570 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:20 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:20 volumioliu volumio[3494]: info: Nov 01 09:42:20 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand stop took 42 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/外婆的澎湖湾.dsf Nov 01 09:42:20 volumioliu volumio[3494]: info: Setting Volume to 100 automatically for DSD Nov 01 09:42:20 volumioliu volumio[3494]: info: VolumeController::SetAlsaVolume100 Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand status took 31 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand stop took 12 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:20 volumioliu volumio[3494]: info: Nov 01 09:42:20 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:20 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand clear took 3 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/外婆的澎湖湾.dsf" Nov 01 09:42:20 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: 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":"男儿当自强.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/男儿当自强.dsf","trackType":"dsf"} Nov 01 09:42:20 volumioliu volumio[3494]: verbose: CURRENT POSITION 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:20 volumioliu volumio[3494]: info: No code Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:20 volumioliu volumio[3494]: info: ------------------------------ 58ms Nov 01 09:42:20 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:20 volumioliu volumio[3494]: info: Nov 01 09:42:20 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:20 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:20 volumioliu volumio[3494]: info: ------------------------------ 24ms Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/外婆的澎湖湾.dsf" took 23 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:20 volumioliu volumio[3494]: info: Nov 01 09:42:20 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:20 volumioliu volumio[3494]: info: ------------------------------ 7ms Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand play took 7 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:20 volumioliu volumio[3494]: info: Nov 01 09:42:20 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:20 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand status took 50 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:20 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"外婆的澎湖湾.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/外婆的澎湖湾.dsf","trackType":"dsf"} Nov 01 09:42:20 volumioliu volumio[3494]: verbose: CURRENT POSITION 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:20 volumioliu volumio[3494]: info: ------------------------------ 56ms Nov 01 09:42:20 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 01 09:42:20 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:20 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":197,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"外婆的澎湖湾.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/外婆的澎湖湾.dsf","trackType":"dsf"} Nov 01 09:42:20 volumioliu volumio[3494]: verbose: CURRENT POSITION 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:20 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:20 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:20 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:20 volumioliu volumio[3494]: info: ------------------------------ 19ms Nov 01 09:42:23 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::volumioNext Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::next Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 254 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:24 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:24 volumioliu volumio[3494]: info: Nov 01 09:42:24 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand stop took 16 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/相依为命.wav Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand stop took 1 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:24 volumioliu volumio[3494]: info: Nov 01 09:42:24 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:24 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand clear took 0 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/相依为命.wav" Nov 01 09:42:24 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: 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":"外婆的澎湖湾.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/外婆的澎湖湾.dsf","trackType":"dsf"} Nov 01 09:42:24 volumioliu volumio[3494]: verbose: CURRENT POSITION 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:24 volumioliu volumio[3494]: info: No code Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:24 volumioliu volumio[3494]: info: ------------------------------ 19ms Nov 01 09:42:24 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:24 volumioliu volumio[3494]: info: Nov 01 09:42:24 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:24 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:24 volumioliu volumio[3494]: info: ------------------------------ 17ms Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/相依为命.wav" took 16 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:24 volumioliu volumio[3494]: info: Nov 01 09:42:24 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:24 volumioliu volumio[3494]: info: ------------------------------ 7ms Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand play took 7 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:24 volumioliu volumio[3494]: info: Nov 01 09:42:24 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:24 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand status took 1 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:24 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相依为命.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/相依为命.wav","trackType":"wav"} Nov 01 09:42:24 volumioliu volumio[3494]: verbose: CURRENT POSITION 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:24 volumioliu volumio[3494]: info: ------------------------------ 6ms Nov 01 09:42:24 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 01 09:42:24 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:24 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相依为命.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/相依为命.wav","trackType":"wav"} Nov 01 09:42:24 volumioliu volumio[3494]: verbose: CURRENT POSITION 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:24 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:24 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:24 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:24 volumioliu volumio[3494]: info: ------------------------------ 26ms Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPrevious Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreStateMachine::previous Nov 01 09:42:25 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:25 volumioliu volumio[3494]: info: ControllerMpd::seek Nov 01 09:42:25 volumioliu volumio[3494]: error: null Nov 01 09:42:25 volumioliu volumio[3494]: info: Nov 01 09:42:25 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:25 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:25 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:25 volumioliu volumio[3494]: info: sendMpdCommand status took 0 milliseconds Nov 01 09:42:25 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:25 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:25 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:25 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:25 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:25 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:25 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相依为命.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/相依为命.wav","trackType":"wav"} Nov 01 09:42:25 volumioliu volumio[3494]: verbose: CURRENT POSITION 581 Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:25 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:25 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:25 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:25 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:25 volumioliu volumio[3494]: info: ------------------------------ 17ms Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPrevious Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::previous Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:26 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:26 volumioliu volumio[3494]: info: Nov 01 09:42:26 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand stop took 43 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand status took 1 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:26 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:26 volumioliu volumio[3494]: 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":"相依为命.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/相依为命.wav","trackType":"wav"} Nov 01 09:42:26 volumioliu volumio[3494]: verbose: CURRENT POSITION 581 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:26 volumioliu volumio[3494]: info: No code Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 581 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:26 volumioliu volumio[3494]: info: ------------------------------ 23ms Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 493 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 493 Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/欧若拉.wav Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand stop took 0 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:26 volumioliu volumio[3494]: info: Nov 01 09:42:26 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:26 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand clear took 1 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/欧若拉.wav" Nov 01 09:42:26 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:26 volumioliu volumio[3494]: info: Nov 01 09:42:26 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:26 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:26 volumioliu volumio[3494]: info: ------------------------------ 3ms Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/欧若拉.wav" took 1 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:26 volumioliu volumio[3494]: info: ------------------------------ 2ms Nov 01 09:42:26 volumioliu volumio[3494]: info: Nov 01 09:42:26 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand play took 2 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:26 volumioliu volumio[3494]: info: Nov 01 09:42:26 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand status took 3 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand status took 1 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:26 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 493 Nov 01 09:42:26 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"欧若拉.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/欧若拉.wav","trackType":"wav"} Nov 01 09:42:26 volumioliu volumio[3494]: verbose: CURRENT POSITION 493 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:26 volumioliu volumio[3494]: info: ------------------------------ 8ms Nov 01 09:42:26 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 01 09:42:26 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:26 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 493 Nov 01 09:42:26 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"欧若拉.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/欧若拉.wav","trackType":"wav"} Nov 01 09:42:26 volumioliu volumio[3494]: verbose: CURRENT POSITION 493 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:26 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 493 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:26 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 493 Nov 01 09:42:26 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:26 volumioliu volumio[3494]: info: ------------------------------ 24ms Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::volumioNext Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::next Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 493 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 493 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:29 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:29 volumioliu volumio[3494]: info: Nov 01 09:42:29 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand stop took 21 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/伤心的我.dsf Nov 01 09:42:29 volumioliu volumio[3494]: info: Setting Volume to 100 automatically for DSD Nov 01 09:42:29 volumioliu volumio[3494]: info: VolumeController::SetAlsaVolume100 Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand status took 32 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand stop took 12 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:29 volumioliu volumio[3494]: info: Nov 01 09:42:29 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:29 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand clear took 9 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/伤心的我.dsf" Nov 01 09:42:29 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: 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":"欧若拉.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/欧若拉.wav","trackType":"wav"} Nov 01 09:42:29 volumioliu volumio[3494]: verbose: CURRENT POSITION 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:29 volumioliu volumio[3494]: info: No code Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:29 volumioliu volumio[3494]: info: ------------------------------ 59ms Nov 01 09:42:29 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:29 volumioliu volumio[3494]: info: Nov 01 09:42:29 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:29 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:29 volumioliu volumio[3494]: info: ------------------------------ 20ms Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/伤心的我.dsf" took 18 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:29 volumioliu volumio[3494]: info: Nov 01 09:42:29 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:29 volumioliu volumio[3494]: info: ------------------------------ 10ms Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand play took 11 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:29 volumioliu volumio[3494]: info: Nov 01 09:42:29 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:29 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand status took 30 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand status took 4 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:29 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":257,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"伤心的我.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/伤心的我.dsf","trackType":"dsf"} Nov 01 09:42:29 volumioliu volumio[3494]: verbose: CURRENT POSITION 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:29 volumioliu volumio[3494]: info: ------------------------------ 36ms Nov 01 09:42:29 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 26 milliseconds Nov 01 09:42:29 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:29 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":394,"duration":257,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"伤心的我.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/伤心的我.dsf","trackType":"dsf"} Nov 01 09:42:29 volumioliu volumio[3494]: verbose: CURRENT POSITION 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:29 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:29 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:29 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:29 volumioliu volumio[3494]: info: ------------------------------ 45ms Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreCommandRouter::volumioNext Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreStateMachine::next Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:32 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:32 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:32 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 109 Nov 01 09:42:32 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:32 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:33 volumioliu volumio[3494]: info: Nov 01 09:42:33 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand stop took 34 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/稻香二珂.mp3 Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand stop took 1 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:33 volumioliu volumio[3494]: info: Nov 01 09:42:33 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:33 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand clear took 1 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/稻香二珂.mp3" Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: 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":"伤心的我.dsf","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/伤心的我.dsf","trackType":"dsf"} Nov 01 09:42:33 volumioliu volumio[3494]: verbose: CURRENT POSITION 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:33 volumioliu volumio[3494]: info: No code Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:33 volumioliu volumio[3494]: info: ------------------------------ 21ms Nov 01 09:42:33 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:33 volumioliu volumio[3494]: info: Nov 01 09:42:33 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:33 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:33 volumioliu volumio[3494]: info: ------------------------------ 19ms Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/稻香二珂.mp3" took 19 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:33 volumioliu volumio[3494]: info: Nov 01 09:42:33 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:33 volumioliu volumio[3494]: info: ------------------------------ 6ms Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand play took 5 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:33 volumioliu volumio[3494]: info: Nov 01 09:42:33 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"稻香二珂.mp3","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/稻香二珂.mp3","trackType":"mp3"} Nov 01 09:42:33 volumioliu volumio[3494]: verbose: CURRENT POSITION 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:33 volumioliu volumio[3494]: info: ------------------------------ 4ms Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"稻香二珂.mp3","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/稻香二珂.mp3","trackType":"mp3"} Nov 01 09:42:33 volumioliu volumio[3494]: verbose: CURRENT POSITION 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:33 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:33 volumioliu volumio[3494]: info: ------------------------------ 17ms Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPrevious Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::previous Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::seek Nov 01 09:42:33 volumioliu volumio[3494]: error: null Nov 01 09:42:33 volumioliu volumio[3494]: info: Nov 01 09:42:33 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand status took 1 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:33 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 01 09:42:33 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:33 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"稻香二珂.mp3","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/稻香二珂.mp3","trackType":"mp3"} Nov 01 09:42:33 volumioliu volumio[3494]: verbose: CURRENT POSITION 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:33 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:33 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:33 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:33 volumioliu volumio[3494]: info: ------------------------------ 16ms Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPrevious Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreStateMachine::previous Nov 01 09:42:34 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:34 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:34 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:34 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:34 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:34 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:34 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:35 volumioliu volumio[3494]: info: Nov 01 09:42:35 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand stop took 27 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand status took 0 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:35 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:35 volumioliu volumio[3494]: 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":"稻香二珂.mp3","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/稻香二珂.mp3","trackType":"mp3"} Nov 01 09:42:35 volumioliu volumio[3494]: verbose: CURRENT POSITION 600 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:35 volumioliu volumio[3494]: info: No code Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 600 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:35 volumioliu volumio[3494]: info: ------------------------------ 17ms Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 337 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 337 Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/左边.wav Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand stop took 1 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:35 volumioliu volumio[3494]: info: Nov 01 09:42:35 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:35 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand clear took 0 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/左边.wav" Nov 01 09:42:35 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:35 volumioliu volumio[3494]: info: Nov 01 09:42:35 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:35 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:35 volumioliu volumio[3494]: info: ------------------------------ 1ms Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/左边.wav" took 1 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:35 volumioliu volumio[3494]: info: ------------------------------ 1ms Nov 01 09:42:35 volumioliu volumio[3494]: info: Nov 01 09:42:35 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand play took 1 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:35 volumioliu volumio[3494]: info: Nov 01 09:42:35 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand status took 3 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand status took 1 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:35 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 337 Nov 01 09:42:35 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"左边.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/左边.wav","trackType":"wav"} Nov 01 09:42:35 volumioliu volumio[3494]: verbose: CURRENT POSITION 337 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:35 volumioliu volumio[3494]: info: ------------------------------ 6ms Nov 01 09:42:35 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:35 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:35 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 337 Nov 01 09:42:35 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"左边.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/左边.wav","trackType":"wav"} Nov 01 09:42:35 volumioliu volumio[3494]: verbose: CURRENT POSITION 337 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:35 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 337 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:35 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 337 Nov 01 09:42:35 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:35 volumioliu volumio[3494]: info: ------------------------------ 25ms Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::volumioNext Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::next Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 337 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 337 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:36 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:36 volumioliu volumio[3494]: info: Nov 01 09:42:36 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand stop took 50 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/Spectrum.flac Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand status took 6 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand stop took 4 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:36 volumioliu volumio[3494]: info: Nov 01 09:42:36 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:36 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand clear took 1 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/Spectrum.flac" Nov 01 09:42:36 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: 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":"左边.wav","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/左边.wav","trackType":"wav"} Nov 01 09:42:36 volumioliu volumio[3494]: verbose: CURRENT POSITION 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:36 volumioliu volumio[3494]: info: No code Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:36 volumioliu volumio[3494]: info: ------------------------------ 38ms Nov 01 09:42:36 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:36 volumioliu volumio[3494]: info: Nov 01 09:42:36 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:36 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:36 volumioliu volumio[3494]: info: ------------------------------ 31ms Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/Spectrum.flac" took 30 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:36 volumioliu volumio[3494]: info: Nov 01 09:42:36 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:36 volumioliu volumio[3494]: info: ------------------------------ 7ms Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand play took 6 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:36 volumioliu volumio[3494]: info: Nov 01 09:42:36 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:36 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:36 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Spectrum.flac","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/Spectrum.flac","trackType":"flac"} Nov 01 09:42:36 volumioliu volumio[3494]: verbose: CURRENT POSITION 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:36 volumioliu volumio[3494]: info: ------------------------------ 6ms Nov 01 09:42:36 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 01 09:42:36 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:36 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Spectrum.flac","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/Spectrum.flac","trackType":"flac"} Nov 01 09:42:36 volumioliu volumio[3494]: verbose: CURRENT POSITION 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:36 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:36 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:36 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:36 volumioliu volumio[3494]: info: ------------------------------ 27ms Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::volumioNext Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::next Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 25 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:37 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:37 volumioliu volumio[3494]: info: Nov 01 09:42:37 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand stop took 18 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/赵鹏叶赛尼娅.flac Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand stop took 1 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:37 volumioliu volumio[3494]: info: Nov 01 09:42:37 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:37 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand clear took 1 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/赵鹏叶赛尼娅.flac" Nov 01 09:42:37 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: 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":"Spectrum.flac","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/Spectrum.flac","trackType":"flac"} Nov 01 09:42:37 volumioliu volumio[3494]: verbose: CURRENT POSITION 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:37 volumioliu volumio[3494]: info: No code Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:37 volumioliu volumio[3494]: info: ------------------------------ 18ms Nov 01 09:42:37 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:37 volumioliu volumio[3494]: info: Nov 01 09:42:37 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:37 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:37 volumioliu volumio[3494]: info: ------------------------------ 17ms Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/赵鹏叶赛尼娅.flac" took 16 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:37 volumioliu volumio[3494]: info: Nov 01 09:42:37 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:37 volumioliu volumio[3494]: info: ------------------------------ 10ms Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand play took 10 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:37 volumioliu volumio[3494]: info: Nov 01 09:42:37 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand status took 31 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand status took 3 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:37 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":251,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"叶赛尼娅","artist":"赵鹏","album":"叶赛尼娅","uri":"USB/C8E0-9691/04wxh/赵鹏叶赛尼娅.flac","trackType":"flac"} Nov 01 09:42:37 volumioliu volumio[3494]: verbose: CURRENT POSITION 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:37 volumioliu volumio[3494]: info: ------------------------------ 36ms Nov 01 09:42:37 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 01 09:42:37 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:37 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":251,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"796 Kbps","isStreaming":false,"title":"叶赛尼娅","artist":"赵鹏","album":"叶赛尼娅","uri":"USB/C8E0-9691/04wxh/赵鹏叶赛尼娅.flac","trackType":"flac"} Nov 01 09:42:37 volumioliu volumio[3494]: verbose: CURRENT POSITION 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:37 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:37 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:37 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:37 volumioliu volumio[3494]: info: ------------------------------ 19ms Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::volumioNext Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::next Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::stop Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::stPlaybackTimer Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::serviceStop Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 741 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::serviceStop Nov 01 09:42:51 volumioliu volumio[3494]: info: ControllerMpd::stop Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:51 volumioliu volumio[3494]: info: Nov 01 09:42:51 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand stop took 25 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::play index undefined Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::startPlaybackTimer Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::clearAddPlayTracks USB/C8E0-9691/04wxh/刘芳纸飞机.flac Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::updateTrackBlock Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrackBlock Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand status took 3 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand stop took 2 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 09:42:51 volumioliu volumio[3494]: info: Nov 01 09:42:51 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:51 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand clear took 2 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand add "USB/C8E0-9691/04wxh/刘芳纸飞机.flac" Nov 01 09:42:51 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: 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":"USB/C8E0-9691/04wxh/赵鹏叶赛尼娅.flac","trackType":"flac"} Nov 01 09:42:51 volumioliu volumio[3494]: verbose: CURRENT POSITION 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService stop Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:51 volumioliu volumio[3494]: info: No code Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:51 volumioliu volumio[3494]: info: ------------------------------ 22ms Nov 01 09:42:51 volumioliu volumio[3494]: error: updateQueue error: null Nov 01 09:42:51 volumioliu volumio[3494]: info: Nov 01 09:42:51 volumioliu volumio[3494]: ---------------------------- MPD announces system playlist update Nov 01 09:42:51 volumioliu volumio[3494]: info: Ignoring MPD Status Update Nov 01 09:42:51 volumioliu volumio[3494]: info: ------------------------------ 18ms Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand add "USB/C8E0-9691/04wxh/刘芳纸飞机.flac" took 17 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand play Nov 01 09:42:51 volumioliu volumio[3494]: info: Nov 01 09:42:51 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:51 volumioliu volumio[3494]: info: ------------------------------ 5ms Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand play took 5 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:51 volumioliu volumio[3494]: info: Nov 01 09:42:51 volumioliu volumio[3494]: ---------------------------- MPD announces state update: player Nov 01 09:42:51 volumioliu volumio[3494]: info: ControllerMpd::getState Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand status Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand status took 2 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand status took 1 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::parseState Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:51 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"刘芳纸飞机.flac","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/刘芳纸飞机.flac","trackType":"flac"} Nov 01 09:42:51 volumioliu volumio[3494]: verbose: CURRENT POSITION 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus stop Nov 01 09:42:51 volumioliu volumio[3494]: info: ------------------------------ 6ms Nov 01 09:42:51 volumioliu volumio[3494]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 09:42:51 volumioliu volumio[3494]: verbose: ControllerMpd::parseTrackInfo Nov 01 09:42:51 volumioliu volumio[3494]: info: ControllerMpd::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::servicePushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"刘芳纸飞机.flac","artist":null,"album":null,"uri":"USB/C8E0-9691/04wxh/刘芳纸飞机.flac","trackType":"flac"} Nov 01 09:42:51 volumioliu volumio[3494]: verbose: CURRENT POSITION 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::syncState stateService play Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::syncState currentStatus play Nov 01 09:42:51 volumioliu volumio[3494]: info: Received an update from plugin. extracting info from payload Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreStateMachine::pushState Nov 01 09:42:51 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:51 volumioliu volumio[3494]: info: CoreCommandRouter::volumioPushState Nov 01 09:42:51 volumioliu volumio[3494]: info: ------------------------------ 18ms Nov 01 09:42:58 volumioliu sudo[6394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 09:42:58 volumioliu sudo[6394]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:42:58 volumioliu sudo[6394]: pam_unix(sudo:session): session closed for user root Nov 01 09:42:58 volumioliu sudo[6397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 09:42:58 volumioliu sudo[6397]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:42:58 volumioliu sudo[6397]: pam_unix(sudo:session): session closed for user root Nov 01 09:42:58 volumioliu volumio[3494]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.101 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:58 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 09:42:58 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:58 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:58 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:58 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:58 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetQueue Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreStateMachine::getQueue Nov 01 09:42:58 volumioliu volumio[3494]: info: CorePlayQueue::getQueue Nov 01 09:42:58 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:58 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:58 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:58 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:58 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:42:58 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:58 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:42:58 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:42:58 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu sudo[6404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 09:43:00 volumioliu sudo[6404]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:43:00 volumioliu sudo[6404]: pam_unix(sudo:session): session closed for user root Nov 01 09:43:00 volumioliu sudo[6407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 09:43:00 volumioliu sudo[6407]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:43:00 volumioliu sudo[6407]: pam_unix(sudo:session): session closed for user root Nov 01 09:43:00 volumioliu volumio[3494]: verbose: New Socket.io Connection to 192.168.1.104 from 192.168.1.101 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 09:43:00 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:43:00 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetQueue Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreStateMachine::getQueue Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getQueue Nov 01 09:43:00 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:43:00 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:43:00 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu volumio[3494]: info: Received Get System Info Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 09:43:00 volumioliu volumio[3494]: info: Discovery: Getting this device information Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 09:43:00 volumioliu volumio[3494]: info: CoreCommandRouter::volumioGetState Nov 01 09:43:00 volumioliu volumio[3494]: info: CorePlayQueue::getTrack 188 Nov 01 09:43:06 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 09:43:06 volumioliu volumio[3494]: info: CURURI: music-library Nov 01 09:43:07 volumioliu volumio[3494]: info: Preload queue cleared Nov 01 09:43:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 09:43:08 volumioliu volumio[3494]: info: CURURI: music-library/USB Nov 01 09:43:08 volumioliu volumio[3494]: info: Preload queue cleared Nov 01 09:43:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 09:43:08 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 09:43:08 volumioliu volumio[3494]: info: CURURI: music-library/USB/C8E0-9691 Nov 01 09:43:08 volumioliu volumio[3494]: info: Preload queue cleared Nov 01 09:43:10 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 09:43:13 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 09:43:13 volumioliu volumio[3494]: info: CURURI: music-library/USB/C8E0-9691/01xph Nov 01 09:43:13 volumioliu volumio[3494]: info: Preload queue cleared Nov 01 09:43:20 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:43:27 volumioliu volumio[3494]: info: Saving local item xph Nov 01 09:43:27 volumioliu volumio[3494]: info: Pushing Favourites {"uri":"/mnt/USB/C8E0-9691/01xph","favourite":false} Nov 01 09:43:27 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:43:33 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:43:40 volumioliu volumio[3494]: info: Saving local item alp Nov 01 09:43:40 volumioliu volumio[3494]: info: Pushing Favourites {"uri":"/mnt/USB/C8E0-9691/02alp","favourite":false} Nov 01 09:43:40 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:43:46 volumioliu volumio[3494]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 09:43:46 volumioliu volumio[3494]: info: CURURI: playlists Nov 01 09:43:46 volumioliu volumio[3494]: info: Listing playlists Nov 01 09:43:46 volumioliu volumio[3494]: info: Preload queue cleared Nov 01 09:43:47 volumioliu volumio[3494]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 09:43:47 volumioliu volumio[3494]: Error: connect ETIMEDOUT 31.13.84.2:443 Nov 01 09:43:47 volumioliu volumio[3494]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 01 09:43:47 volumioliu volumio[3494]: errno: -110, Nov 01 09:43:47 volumioliu volumio[3494]: code: 'ETIMEDOUT', Nov 01 09:43:47 volumioliu volumio[3494]: syscall: 'connect', Nov 01 09:43:47 volumioliu volumio[3494]: address: '31.13.84.2', Nov 01 09:43:47 volumioliu volumio[3494]: port: 443 Nov 01 09:43:47 volumioliu volumio[3494]: } Nov 01 09:43:47 volumioliu volumio[3494]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 09:43:47 volumioliu sudo[6554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-01 09:42 Nov 01 09:43:47 volumioliu sudo[6554]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"