Jan 09 20:07:05 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:05 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:05 volumio volumio[19952]: info: Listing playlists
Jan 09 20:07:05 volumio volumio[19952]: info: Listing playlists
Jan 09 20:07:15 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:15 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:17 volumio sudo[20428]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 09 20:07:17 volumio sudo[20428]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 09 20:07:17 volumio sudo[20428]: pam_unix(sudo:session): session closed for user root
Jan 09 20:07:17 volumio sudo[20430]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 09 20:07:17 volumio sudo[20430]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 09 20:07:17 volumio sudo[20430]: pam_unix(sudo:session): session closed for user root
Jan 09 20:07:17 volumio volumio[19952]: verbose: New Socket.io Connection to 192.168.31.86 from 192.168.31.199 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jan 09 20:07:18 volumio sudo[20436]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 09 20:07:18 volumio sudo[20436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 09 20:07:18 volumio sudo[20436]: pam_unix(sudo:session): session closed for user root
Jan 09 20:07:18 volumio sudo[20438]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 09 20:07:18 volumio sudo[20438]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 09 20:07:18 volumio sudo[20438]: pam_unix(sudo:session): session closed for user root
Jan 09 20:07:18 volumio volumio[19952]: verbose: New Socket.io Connection to 192.168.31.86 from 192.168.31.199 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:18 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 09 20:07:18 volumio volumio[19952]: info: Received Get System Info
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 09 20:07:18 volumio volumio[19952]: info: Discovery: Getting this device information
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:18 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:18 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:18 volumio volumio[19952]: info: Listing playlists
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 09 20:07:18 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 09 20:07:19 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:19 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 09 20:07:20 volumio volumio[19952]: info: Received Get System Info
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 09 20:07:20 volumio volumio[19952]: info: Discovery: Getting this device information
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioNext
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::next
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::stop
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::stPlaybackTimer
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::serviceStop
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 971
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::serviceStop
Jan 09 20:07:20 volumio volumio[19952]: info: ControllerMpd::stop
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand stop took 12 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/江美琪 - 那年的情书.flac
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand stop took 3 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:20 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:20 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:20 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand clear took 7 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand status took 4 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/江美琪 - 那年的情书.flac"
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:20 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: 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":null,"uri":"NAS/4800/#recycle/music/yinyue/陈小春 - 算你狠.flac","trackType":"flac"}
Jan 09 20:07:20 volumio volumio[19952]: verbose: CURRENT POSITION 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: No code
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:20 volumio volumio[19952]: verbose: CURRENT POSITION 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: No code
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:20 volumio volumio[19952]: verbose: CURRENT POSITION 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: No code
Jan 09 20:07:20 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:20 volumio volumio[19952]: info: CorePlayQueue::getTrack 1155
Jan 09 20:07:20 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 103ms
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 94ms
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 95ms
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:20 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:20 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:20 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:20 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 102ms
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/江美琪 - 那年的情书.flac" took 99 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 9ms
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 6ms
Jan 09 20:07:20 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:20 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:20 volumio volumio[19952]: info:
Jan 09 20:07:20 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:20 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 54ms
Jan 09 20:07:20 volumio volumio[19952]: info: sendMpdCommand play took 51 milliseconds
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 50ms
Jan 09 20:07:20 volumio volumio[19952]: info: ------------------------------ 49ms
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioNext
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::next
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 45 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 34 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 33 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand stop took 9 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: Upnp client error: Error: This socket has been ended by the other party
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:23 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 18 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 17 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand clear took 15 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 12 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 10 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac"
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2865,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"595 Kbps","isStreaming":false,"title":"那年的情书","artist":"江美琪","album":"恋人心中有一首诗","uri":"NAS/4800/#recycle/music/yinyue/江美琪 - 那年的情书.flac","trackType":"flac"}
Jan 09 20:07:23 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2865,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"727 Kbps","isStreaming":false,"title":"那年的情书","artist":"江美琪","album":"恋人心中有一首诗","uri":"NAS/4800/#recycle/music/yinyue/江美琪 - 那年的情书.flac","trackType":"flac"}
Jan 09 20:07:23 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:23 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2865,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"727 Kbps","isStreaming":false,"title":"那年的情书","artist":"江美琪","album":"恋人心中有一首诗","uri":"NAS/4800/#recycle/music/yinyue/江美琪 - 那年的情书.flac","trackType":"flac"}
Jan 09 20:07:23 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:23 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:23 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:23 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: No code
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 111ms
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 149ms
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 147ms
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 108ms
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 109ms
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:23 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:23 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:23 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 123ms
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 117 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 117 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac" took 116 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand stop took 24 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 9ms
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 9 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 8ms
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand status took 7 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:23 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:23 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:23 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: No code
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:23 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: No code
Jan 09 20:07:23 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:23 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:23 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 176ms
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 176ms
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 77ms
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 77ms
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:23 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:23 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:23 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:23 volumio volumio[19952]: info:
Jan 09 20:07:23 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:23 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:23 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 152ms
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand play took 146 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: sendMpdCommand clear took 146 milliseconds
Jan 09 20:07:23 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 78ms
Jan 09 20:07:23 volumio volumio[19952]: info: ------------------------------ 78ms
Jan 09 20:07:23 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac"
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:24 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:24 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:24 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:24 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 698ms
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 696 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac" took 696 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 9ms
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 8 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: No code
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: No code
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 760ms
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 71ms
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:24 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:24 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 77ms
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 75 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 74ms
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand play took 70 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: No code
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 113ms
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 91ms
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 91ms
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 86 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 8 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 4 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"790 Kbps","isStreaming":false,"title":"故事的角色","artist":"王杰","album":"Wang Chieh Disc 1 of 3","uri":"NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac","trackType":"flac"}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 104ms
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:24 volumio volumio[19952]: info:
Jan 09 20:07:24 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand status took 3 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"777 Kbps","isStreaming":false,"title":"故事的角色","artist":"王杰","album":"Wang Chieh Disc 1 of 3","uri":"NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac","trackType":"flac"}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:24 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"777 Kbps","isStreaming":false,"title":"故事的角色","artist":"王杰","album":"Wang Chieh Disc 1 of 3","uri":"NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac","trackType":"flac"}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:24 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"777 Kbps","isStreaming":false,"title":"故事的角色","artist":"王杰","album":"Wang Chieh Disc 1 of 3","uri":"NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac","trackType":"flac"}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:24 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 76ms
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 71ms
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 70ms
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 53 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 53 milliseconds
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:24 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"777 Kbps","isStreaming":false,"title":"故事的角色","artist":"王杰","album":"Wang Chieh Disc 1 of 3","uri":"NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac","trackType":"flac"}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:24 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"777 Kbps","isStreaming":false,"title":"故事的角色","artist":"王杰","album":"Wang Chieh Disc 1 of 3","uri":"NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac","trackType":"flac"}
Jan 09 20:07:24 volumio volumio[19952]: verbose: CURRENT POSITION 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:24 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:24 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:24 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 105ms
Jan 09 20:07:24 volumio volumio[19952]: info: ------------------------------ 104ms
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::volumioNext
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::next
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::stop
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::stPlaybackTimer
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::serviceStop
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrack 1115
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::serviceStop
Jan 09 20:07:25 volumio volumio[19952]: info: ControllerMpd::stop
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand stop took 13 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrack 281
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrack 281
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/孫燿威 - 爱的故事_(上集).flac
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:25 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:25 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand status took 15 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand stop took 13 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand status took 7 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand status took 6 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:25 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand clear took 7 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/孫燿威 - 爱的故事_(上集).flac"
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:25 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrack 281
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrack 281
Jan 09 20:07:25 volumio volumio[19952]: 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":"Wang Chieh Disc 1 of 3","uri":"NAS/4800/#recycle/music/yinyue/王杰 - 故事的角色.flac","trackType":"flac"}
Jan 09 20:07:25 volumio volumio[19952]: verbose: CURRENT POSITION 281
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrack 281
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:25 volumio volumio[19952]: info: No code
Jan 09 20:07:25 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:25 volumio volumio[19952]: info: CorePlayQueue::getTrack 281
Jan 09 20:07:25 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:25 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:25 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 73ms
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 64ms
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 60ms
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:25 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:25 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:25 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:25 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 60ms
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/孫燿威 - 爱的故事_(上集).flac" took 57 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 13ms
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 12ms
Jan 09 20:07:25 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:25 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:25 volumio volumio[19952]: info:
Jan 09 20:07:25 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:25 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 41ms
Jan 09 20:07:25 volumio volumio[19952]: info: sendMpdCommand play took 37 milliseconds
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 35ms
Jan 09 20:07:25 volumio volumio[19952]: info: ------------------------------ 32ms
Jan 09 20:07:27 volumio nmbd[1016]: [2026/01/09 20:07:27.453368, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jan 09 20:07:27 volumio nmbd[1016]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.31.86 for name WORKGROUP<1d>.
Jan 09 20:07:27 volumio nmbd[1016]: This response was from IP 192.168.31.87, reporting an IP address of 192.168.31.87.
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 3 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioNext
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::next
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::stop
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 27 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 26 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 26 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 25 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand stop took 17 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 3 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3576,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"837 Kbps","isStreaming":false,"title":"爱的故事_(上集)","artist":"孫燿威","album":null,"uri":"NAS/4800/#recycle/music/yinyue/孫燿威 - 爱的故事_(上集).flac","trackType":"flac"}
Jan 09 20:07:29 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:29 volumio volumio[19952]: info: ------------------------------ 38ms
Jan 09 20:07:29 volumio volumio[19952]: Upnp client error: Error: This socket has been ended by the other party
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:29 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 15 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand clear took 14 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac"
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3576,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"837 Kbps","isStreaming":false,"title":"爱的故事_(上集)","artist":"孫燿威","album":null,"uri":"NAS/4800/#recycle/music/yinyue/孫燿威 - 爱的故事_(上集).flac","trackType":"flac"}
Jan 09 20:07:29 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:29 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3576,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"837 Kbps","isStreaming":false,"title":"爱的故事_(上集)","artist":"孫燿威","album":null,"uri":"NAS/4800/#recycle/music/yinyue/孫燿威 - 爱的故事_(上集).flac","trackType":"flac"}
Jan 09 20:07:29 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:29 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3576,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"837 Kbps","isStreaming":false,"title":"爱的故事_(上集)","artist":"孫燿威","album":null,"uri":"NAS/4800/#recycle/music/yinyue/孫燿威 - 爱的故事_(上集).flac","trackType":"flac"}
Jan 09 20:07:29 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:29 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:29 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:29 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:29 volumio volumio[19952]: info: ------------------------------ 108ms
Jan 09 20:07:29 volumio volumio[19952]: info: ------------------------------ 107ms
Jan 09 20:07:29 volumio volumio[19952]: info: ------------------------------ 108ms
Jan 09 20:07:29 volumio volumio[19952]: info: ------------------------------ 85ms
Jan 09 20:07:29 volumio volumio[19952]: info: ------------------------------ 84ms
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:29 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:29 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:29 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:29 volumio volumio[19952]: info:
Jan 09 20:07:29 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:29 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 83 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand status took 83 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: ------------------------------ 82ms
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 79 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac" took 79 milliseconds
Jan 09 20:07:29 volumio volumio[19952]: info: ------------------------------ 6ms
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:29 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:29 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:29 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:29 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:29 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:30 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:30 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: No code
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 132ms
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 131ms
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 146ms
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:30 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:30 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 120ms
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 119ms
Jan 09 20:07:30 volumio volumio[19952]: info: sendMpdCommand play took 115 milliseconds
Jan 09 20:07:30 volumio volumio[19952]: info: sendMpdCommand stop took 72 milliseconds
Jan 09 20:07:30 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 8ms
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 7ms
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:30 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:30 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:30 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:30 volumio volumio[19952]: info: sendMpdCommand status took 14 milliseconds
Jan 09 20:07:30 volumio volumio[19952]: info: sendMpdCommand clear took 13 milliseconds
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac"
Jan 09 20:07:30 volumio volumio[19952]: info: Listing playlists
Jan 09 20:07:30 volumio volumio[19952]: info: Listing playlists
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:30 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:30 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:30 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:30 volumio volumio[19952]: info:
Jan 09 20:07:30 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:30 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:30 volumio volumio[19952]: info: sendMpdCommand status took 849 milliseconds
Jan 09 20:07:30 volumio volumio[19952]: info: sendMpdCommand status took 848 milliseconds
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 847ms
Jan 09 20:07:30 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 845 milliseconds
Jan 09 20:07:30 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac" took 844 milliseconds
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 6ms
Jan 09 20:07:30 volumio volumio[19952]: info: ------------------------------ 5ms
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:30 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:30 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:30 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: No code
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:30 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:30 volumio volumio[19952]: info: No code
Jan 09 20:07:30 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:30 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:30 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:31 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 945ms
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 944ms
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 958ms
Jan 09 20:07:31 volumio volumio[19952]: info:
Jan 09 20:07:31 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:31 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:31 volumio volumio[19952]: info:
Jan 09 20:07:31 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:31 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:31 volumio volumio[19952]: info:
Jan 09 20:07:31 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:31 volumio volumio[19952]: info:
Jan 09 20:07:31 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 109ms
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand play took 106 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 7ms
Jan 09 20:07:31 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:31 volumio volumio[19952]: info:
Jan 09 20:07:31 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:31 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:31 volumio volumio[19952]: info:
Jan 09 20:07:31 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:31 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 39ms
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand status took 35 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand status took 35 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand status took 6 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:31 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":158,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"情与法","artist":"新白娘子传奇原声带","album":null,"uri":"NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac","trackType":"flac"}
Jan 09 20:07:31 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:31 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":158,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"情与法","artist":"新白娘子传奇原声带","album":null,"uri":"NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac","trackType":"flac"}
Jan 09 20:07:31 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:31 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:31 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":158,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"情与法","artist":"新白娘子传奇原声带","album":null,"uri":"NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac","trackType":"flac"}
Jan 09 20:07:31 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:31 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 68ms
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 100ms
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 68ms
Jan 09 20:07:31 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 59 milliseconds
Jan 09 20:07:31 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:31 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":158,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"情与法","artist":"新白娘子传奇原声带","album":null,"uri":"NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac","trackType":"flac"}
Jan 09 20:07:31 volumio volumio[19952]: verbose: CURRENT POSITION 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:31 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:31 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:31 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:31 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:31 volumio volumio[19952]: info: ------------------------------ 96ms
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::volumioNext
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::next
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::stop
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::stPlaybackTimer
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::serviceStop
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrack 411
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::serviceStop
Jan 09 20:07:32 volumio volumio[19952]: info: ControllerMpd::stop
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand stop took 21 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:32 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:32 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand status took 9 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand stop took 6 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand status took 4 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand status took 2 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:32 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand clear took 3 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac"
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:32 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:32 volumio volumio[19952]: 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":null,"uri":"NAS/4800/#recycle/music/yinyue/新白娘子传奇原声带 - 情与法.flac","trackType":"flac"}
Jan 09 20:07:32 volumio volumio[19952]: verbose: CURRENT POSITION 230
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:32 volumio volumio[19952]: info: No code
Jan 09 20:07:32 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:32 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:32 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:32 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:32 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 45ms
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 39ms
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 38ms
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:32 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:32 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:32 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:32 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 38ms
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac" took 36 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 5ms
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 4ms
Jan 09 20:07:32 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:32 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:32 volumio volumio[19952]: info:
Jan 09 20:07:32 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:32 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 23ms
Jan 09 20:07:32 volumio volumio[19952]: info: sendMpdCommand play took 21 milliseconds
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 21ms
Jan 09 20:07:32 volumio volumio[19952]: info: ------------------------------ 20ms
Jan 09 20:07:35 volumio volumio[19952]: info:
Jan 09 20:07:35 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:35 volumio volumio[19952]: info:
Jan 09 20:07:35 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:35 volumio volumio[19952]: info:
Jan 09 20:07:35 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:35 volumio volumio[19952]: info:
Jan 09 20:07:35 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand status took 4 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:35 volumio volumio[19952]: info:
Jan 09 20:07:35 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:35 volumio volumio[19952]: info:
Jan 09 20:07:35 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand status took 24 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand status took 23 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand status took 22 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 21 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand status took 4 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2865,"duration":425,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"630 Kbps","isStreaming":false,"title":"梦回唐朝","artist":"唐朝乐队","album":null,"uri":"NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac","trackType":"flac"}
Jan 09 20:07:35 volumio volumio[19952]: verbose: CURRENT POSITION 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:35 volumio volumio[19952]: info: ------------------------------ 32ms
Jan 09 20:07:35 volumio volumio[19952]: Upnp client error: Error: This socket has been ended by the other party
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand status took 19 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2865,"duration":425,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"630 Kbps","isStreaming":false,"title":"梦回唐朝","artist":"唐朝乐队","album":null,"uri":"NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac","trackType":"flac"}
Jan 09 20:07:35 volumio volumio[19952]: verbose: CURRENT POSITION 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:35 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2865,"duration":425,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"630 Kbps","isStreaming":false,"title":"梦回唐朝","artist":"唐朝乐队","album":null,"uri":"NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac","trackType":"flac"}
Jan 09 20:07:35 volumio volumio[19952]: verbose: CURRENT POSITION 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:35 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2865,"duration":425,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"630 Kbps","isStreaming":false,"title":"梦回唐朝","artist":"唐朝乐队","album":null,"uri":"NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac","trackType":"flac"}
Jan 09 20:07:35 volumio volumio[19952]: verbose: CURRENT POSITION 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:35 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2957,"duration":425,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"604 Kbps","isStreaming":false,"title":"梦回唐朝","artist":"唐朝乐队","album":null,"uri":"NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac","trackType":"flac"}
Jan 09 20:07:35 volumio volumio[19952]: verbose: CURRENT POSITION 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:35 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: ------------------------------ 137ms
Jan 09 20:07:35 volumio volumio[19952]: info: ------------------------------ 136ms
Jan 09 20:07:35 volumio volumio[19952]: info: ------------------------------ 136ms
Jan 09 20:07:35 volumio volumio[19952]: info: ------------------------------ 117ms
Jan 09 20:07:35 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 98 milliseconds
Jan 09 20:07:35 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:35 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2957,"duration":425,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"604 Kbps","isStreaming":false,"title":"梦回唐朝","artist":"唐朝乐队","album":null,"uri":"NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac","trackType":"flac"}
Jan 09 20:07:35 volumio volumio[19952]: verbose: CURRENT POSITION 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:35 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:35 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:35 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:35 volumio volumio[19952]: info: ------------------------------ 140ms
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::volumioNext
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::next
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::stop
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::stPlaybackTimer
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::serviceStop
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 230
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::serviceStop
Jan 09 20:07:36 volumio volumio[19952]: info: ControllerMpd::stop
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:36 volumio volumio[19952]: info:
Jan 09 20:07:36 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:36 volumio volumio[19952]: info: sendMpdCommand stop took 10 milliseconds
Jan 09 20:07:36 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/林志炫 - 单身情歌.flac
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:36 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:36 volumio volumio[19952]: info: sendMpdCommand stop took 2 milliseconds
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:36 volumio volumio[19952]: info:
Jan 09 20:07:36 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:36 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:36 volumio volumio[19952]: info:
Jan 09 20:07:36 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:36 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:36 volumio volumio[19952]: info:
Jan 09 20:07:36 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:36 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:36 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 09 20:07:36 volumio volumio[19952]: info: sendMpdCommand clear took 5 milliseconds
Jan 09 20:07:36 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:36 volumio volumio[19952]: info: sendMpdCommand status took 3 milliseconds
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/林志炫 - 单身情歌.flac"
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:36 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:36 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: 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":null,"uri":"NAS/4800/#recycle/music/yinyue/唐朝乐队 - 梦回唐朝.flac","trackType":"flac"}
Jan 09 20:07:36 volumio volumio[19952]: verbose: CURRENT POSITION 494
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:36 volumio volumio[19952]: info: No code
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:36 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:36 volumio volumio[19952]: verbose: CURRENT POSITION 494
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:36 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:36 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:36 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:36 volumio volumio[19952]: info: No code
Jan 09 20:07:37 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:37 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:37 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:37 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:37 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:37 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:37 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:37 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:37 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:37 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:37 volumio volumio[19952]: verbose: CURRENT POSITION 494
Jan 09 20:07:37 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:37 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:37 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:37 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:37 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:37 volumio volumio[19952]: info: No code
Jan 09 20:07:37 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:37 volumio volumio[19952]: info: CorePlayQueue::getTrack 494
Jan 09 20:07:37 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 88ms
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 81ms
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 81ms
Jan 09 20:07:37 volumio volumio[19952]: info:
Jan 09 20:07:37 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:37 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:37 volumio volumio[19952]: info:
Jan 09 20:07:37 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:37 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:37 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:37 volumio volumio[19952]: info:
Jan 09 20:07:37 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:37 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 84ms
Jan 09 20:07:37 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/林志炫 - 单身情歌.flac" took 81 milliseconds
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 4ms
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 4ms
Jan 09 20:07:37 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:37 volumio volumio[19952]: info:
Jan 09 20:07:37 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:37 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:37 volumio volumio[19952]: info:
Jan 09 20:07:37 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:37 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 32ms
Jan 09 20:07:37 volumio volumio[19952]: info: sendMpdCommand play took 30 milliseconds
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 29ms
Jan 09 20:07:37 volumio volumio[19952]: info: ------------------------------ 29ms
Jan 09 20:07:39 volumio volumio[19952]: info:
Jan 09 20:07:39 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:39 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:39 volumio volumio[19952]: info:
Jan 09 20:07:39 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:39 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:39 volumio volumio[19952]: info:
Jan 09 20:07:39 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:39 volumio volumio[19952]: info:
Jan 09 20:07:39 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:39 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:39 volumio volumio[19952]: info: sendMpdCommand status took 3 milliseconds
Jan 09 20:07:39 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:39 volumio volumio[19952]: info: CoreCommandRouter::volumioNext
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::next
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::stop
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:39 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:39 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/孙悦 - 哭泣的百合花.flac
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:39 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:39 volumio volumio[19952]: info:
Jan 09 20:07:39 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:39 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:39 volumio volumio[19952]: info:
Jan 09 20:07:39 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:39 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:39 volumio volumio[19952]: info:
Jan 09 20:07:39 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:39 volumio volumio[19952]: info: sendMpdCommand status took 26 milliseconds
Jan 09 20:07:39 volumio volumio[19952]: info: sendMpdCommand status took 25 milliseconds
Jan 09 20:07:39 volumio volumio[19952]: info: sendMpdCommand status took 24 milliseconds
Jan 09 20:07:39 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 25 milliseconds
Jan 09 20:07:39 volumio volumio[19952]: info: sendMpdCommand stop took 17 milliseconds
Jan 09 20:07:39 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:39 volumio volumio[19952]: info: sendMpdCommand status took 4 milliseconds
Jan 09 20:07:39 volumio volumio[19952]: info: sendMpdCommand status took 4 milliseconds
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:39 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:39 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:39 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:39 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:39 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3255,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"单身情歌","artist":"林志炫","album":null,"uri":"NAS/4800/#recycle/music/yinyue/林志炫 - 单身情歌.flac","trackType":"flac"}
Jan 09 20:07:39 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:39 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:39 volumio volumio[19952]: info: ------------------------------ 36ms
Jan 09 20:07:39 volumio volumio[19952]: Upnp client error: Error: This socket has been ended by the other party
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand status took 14 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand clear took 12 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand status took 3 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/孙悦 - 哭泣的百合花.flac"
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3255,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"单身情歌","artist":"林志炫","album":null,"uri":"NAS/4800/#recycle/music/yinyue/林志炫 - 单身情歌.flac","trackType":"flac"}
Jan 09 20:07:40 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:40 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3255,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"单身情歌","artist":"林志炫","album":null,"uri":"NAS/4800/#recycle/music/yinyue/林志炫 - 单身情歌.flac","trackType":"flac"}
Jan 09 20:07:40 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:40 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3255,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"967 Kbps","isStreaming":false,"title":"单身情歌","artist":"林志炫","album":null,"uri":"NAS/4800/#recycle/music/yinyue/林志炫 - 单身情歌.flac","trackType":"flac"}
Jan 09 20:07:40 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:40 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:40 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:40 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:40 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: No code
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 147ms
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 147ms
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 146ms
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 126ms
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 125ms
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/孙悦 - 哭泣的百合花.flac
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 114ms
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 113ms
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 135ms
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 133 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/孙悦 - 哭泣的百合花.flac" took 132 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand stop took 26 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 3ms
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:40 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 153ms
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:40 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:40 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 52ms
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 52ms
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand play took 50 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand clear took 49 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 8ms
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 7ms
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/孙悦 - 哭泣的百合花.flac"
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:40 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:40 volumio volumio[19952]: info:
Jan 09 20:07:40 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:40 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 18ms
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand status took 14 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/孙悦 - 哭泣的百合花.flac" took 14 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 7ms
Jan 09 20:07:40 volumio volumio[19952]: info: sendMpdCommand status took 7 milliseconds
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 6ms
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:40 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:40 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: No code
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:40 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: No code
Jan 09 20:07:40 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:40 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:40 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 86ms
Jan 09 20:07:40 volumio volumio[19952]: info: ------------------------------ 76ms
Jan 09 20:07:42 volumio volumio[19952]: info:
Jan 09 20:07:42 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:42 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:42 volumio volumio[19952]: info:
Jan 09 20:07:42 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:42 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:42 volumio volumio[19952]: info:
Jan 09 20:07:42 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:42 volumio volumio[19952]: info:
Jan 09 20:07:42 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:42 volumio volumio[19952]: info: sendMpdCommand status took 2751 milliseconds
Jan 09 20:07:42 volumio volumio[19952]: info: ------------------------------ 2750ms
Jan 09 20:07:42 volumio volumio[19952]: info: sendMpdCommand play took 2746 milliseconds
Jan 09 20:07:42 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:42 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:42 volumio volumio[19952]: info: ------------------------------ 4ms
Jan 09 20:07:42 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:42 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:42 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:42 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:42 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:42 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:42 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:42 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:42 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:42 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:42 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:42 volumio volumio[19952]: verbose: CURRENT POSITION 245
Jan 09 20:07:42 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:42 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:42 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:42 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:42 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:42 volumio volumio[19952]: info: No code
Jan 09 20:07:42 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:42 volumio volumio[19952]: info: CorePlayQueue::getTrack 245
Jan 09 20:07:42 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:42 volumio volumio[19952]: info: ------------------------------ 2786ms
Jan 09 20:07:42 volumio volumio[19952]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E6%82%A6/00f47256-08dc-433a-aeec-12116df5d630.jpg'
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioNext
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::next
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::stop
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::updateTrackBlock
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrackBlock
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 104ms
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand status took 103 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand status took 102 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand stop took 22 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand status took 5 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand status took 13 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand status took 11 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand clear took 11 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand status took 6 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac"
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3255,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"432 Kbps","isStreaming":false,"title":"哭泣的百合花","artist":"孙悦","album":null,"uri":"NAS/4800/#recycle/music/yinyue/孙悦 - 哭泣的百合花.flac","trackType":"flac"}
Jan 09 20:07:43 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3255,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"495 Kbps","isStreaming":false,"title":"哭泣的百合花","artist":"孙悦","album":null,"uri":"NAS/4800/#recycle/music/yinyue/孙悦 - 哭泣的百合花.flac","trackType":"flac"}
Jan 09 20:07:43 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:43 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:43 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::play index undefined
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 143ms
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 176ms
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 78ms
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::startPlaybackTimer
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 69ms
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand status took 82 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 80ms
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 77 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 77 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac" took 76 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand stop took 17 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 4ms
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 3ms
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:43 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info: No code
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:43 volumio volumio[19952]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 114ms
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 127ms
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 125ms
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:43 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 63ms
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand play took 60 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand clear took 59 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 5ms
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac"
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:43 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:43 volumio volumio[19952]: error: updateQueue error: null
Jan 09 20:07:43 volumio volumio[19952]: info:
Jan 09 20:07:43 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:43 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 31ms
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 30ms
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand status took 28 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac" took 27 milliseconds
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:43 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 20:07:43 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:43 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info: No code
Jan 09 20:07:43 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:43 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:43 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:43 volumio volumio[19952]: info: ------------------------------ 121ms
Jan 09 20:07:46 volumio volumio[19952]: info:
Jan 09 20:07:46 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:46 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:46 volumio volumio[19952]: info:
Jan 09 20:07:46 volumio volumio[19952]: ---------------------------- MPD announces system playlist update
Jan 09 20:07:46 volumio volumio[19952]: info: Ignoring MPD Status Update
Jan 09 20:07:46 volumio volumio[19952]: info:
Jan 09 20:07:46 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:46 volumio volumio[19952]: info:
Jan 09 20:07:46 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 3284ms
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand status took 3273 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 3272ms
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand status took 3270 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 3268ms
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand play took 3266 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 4ms
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 4ms
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:46 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: No code
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 09 20:07:46 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState stateService stop
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: No code
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 3328ms
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 3326ms
Jan 09 20:07:46 volumio volumio[19952]: info:
Jan 09 20:07:46 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:46 volumio volumio[19952]: info:
Jan 09 20:07:46 volumio volumio[19952]: ---------------------------- MPD announces state update: player
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::getState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand status took 124 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand status took 123 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:46 volumio volumio[19952]: Upnp client error: Error: This socket has been ended by the other party
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand status took 11 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand status took 11 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseState
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3759,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"爱情转移","artist":"陈奕迅","album":null,"uri":"NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac","trackType":"flac"}
Jan 09 20:07:46 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3759,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"爱情转移","artist":"陈奕迅","album":null,"uri":"NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac","trackType":"flac"}
Jan 09 20:07:46 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:46 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 149ms
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 163ms
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 34 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: info: sendMpdCommand playlistinfo took 34 milliseconds
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:46 volumio volumio[19952]: verbose: ControllerMpd::parseTrackInfo
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3874,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"862 Kbps","isStreaming":false,"title":"爱情转移","artist":"陈奕迅","album":null,"uri":"NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac","trackType":"flac"}
Jan 09 20:07:46 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:46 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: ControllerMpd::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::servicePushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3874,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"862 Kbps","isStreaming":false,"title":"爱情转移","artist":"陈奕迅","album":null,"uri":"NAS/4800/#recycle/music/yinyue/陈奕迅 - 爱情转移.flac","trackType":"flac"}
Jan 09 20:07:46 volumio volumio[19952]: verbose: CURRENT POSITION 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState stateService play
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::syncState currentStatus play
Jan 09 20:07:46 volumio volumio[19952]: info: Received an update from plugin. extracting info from payload
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: CoreStateMachine::pushState
Jan 09 20:07:46 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:07:46 volumio volumio[19952]: info: CoreCommandRouter::volumioPushState
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 81ms
Jan 09 20:07:46 volumio volumio[19952]: info: ------------------------------ 81ms
Jan 09 20:07:46 volumio volumio[19952]: info: Listing playlists
Jan 09 20:07:46 volumio volumio[19952]: info: Listing playlists
Jan 09 20:07:55 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:07:55 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:08:05 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:08:05 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:08:05 volumio volumio[19952]: info: Listing playlists
Jan 09 20:08:05 volumio volumio[19952]: info: Listing playlists
Jan 09 20:08:15 volumio volumio[19952]: info: CoreCommandRouter::volumioGetState
Jan 09 20:08:15 volumio volumio[19952]: info: CorePlayQueue::getTrack 965
Jan 09 20:08:20 volumio volumio[19952]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 09 20:08:20 volumio volumio[19952]: Error: connect ETIMEDOUT 108.160.167.147:80
Jan 09 20:08:20 volumio volumio[19952]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Jan 09 20:08:20 volumio volumio[19952]: errno: -110,
Jan 09 20:08:20 volumio volumio[19952]: code: 'ETIMEDOUT',
Jan 09 20:08:20 volumio volumio[19952]: syscall: 'connect',
Jan 09 20:08:20 volumio volumio[19952]: address: '108.160.167.147',
Jan 09 20:08:20 volumio volumio[19952]: port: 80
Jan 09 20:08:20 volumio volumio[19952]: }
Jan 09 20:08:20 volumio volumio[19952]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 09 20:08:20 volumio sudo[20667]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 20:07'
Jan 09 20:08:20 volumio sudo[20667]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"