-- Logs begin at Fri 2024-07-05 09:08:41 UTC, end at Sat 2024-07-06 09:53:04 UTC. --
Jul 06 09:52:08 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:08 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:08 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:18 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:18 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:18 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:21 localhost volumio[18137]: info: Clearing queue after UPNP request
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::ClearQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::stop
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 06 09:52:21 localhost volumio[18137]: UNSET VOLATILE
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::stPlaybackTimer
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::updateTrackBlock
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::getTrackBlock
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::serviceStop
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:21 localhost volumio[18137]: info: ControllerMpd::stop
Jul 06 09:52:21 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand stop
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::clearPlayQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::saveQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioPushQueue
Jul 06 09:52:21 localhost volumio[18137]: info:
Jul 06 09:52:21 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:21 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:21 localhost volumio[18137]: info:
Jul 06 09:52:21 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:21 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:21 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:21 localhost volumio[18137]: info: sendMpdCommand stop took 50 milliseconds
Jul 06 09:52:21 localhost volumio[18137]: info: Starting UPNP Playback
Jul 06 09:52:21 localhost volumio[18137]: info: Preparing playback through UPNP
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioGetState
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 06 09:52:21 localhost volumio[18137]: error: updateQueue error: null
Jul 06 09:52:21 localhost volumio[18137]: info: ------------------------------ 5ms
Jul 06 09:52:21 localhost volumio[18137]: info: sendMpdCommand status took 4 milliseconds
Jul 06 09:52:21 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:21 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:21 localhost volumio[18137]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 06 09:52:21 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::syncState stateService stop
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:21 localhost volumio[18137]: info: No code
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:21 localhost volumio[18137]: info: ------------------------------ 34ms
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:21 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:21 localhost volumio[18137]: info:
Jul 06 09:52:21 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:21 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:21 localhost volumio[18137]: info:
Jul 06 09:52:21 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:21 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:21 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:21 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:21 localhost volumio[18137]: info:
Jul 06 09:52:21 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:21 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:21 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:21 localhost volumio[18137]: info:
Jul 06 09:52:21 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:21 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:21 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:21 localhost volumio[18137]: info:
Jul 06 09:52:21 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:21 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:21 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:21 localhost volumio[18137]: info:
Jul 06 09:52:21 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:21 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:21 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:22 localhost volumio[18137]: info:
Jul 06 09:52:22 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:22 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:22 localhost volumio[18137]: info: sendMpdCommand status took 3 milliseconds
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:22 localhost volumio[18137]: info:
Jul 06 09:52:22 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:22 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:22 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 06 09:52:22 localhost volumio[18137]: info: sendMpdCommand status took 2 milliseconds
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:22 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:22 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:22 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"离别开出花","artist":null,"album":"离别开出花(弹唱版)","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000025TjRq1JLmOa.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=DAB4333BA0E3577102A8300BF6B37CAF82073292A10A93C8F317405E9ECB076280191A6A615AE916215D34B8507AA29CCDB046BCB67727A2&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:22 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:22 localhost volumio[18137]: info: ------------------------------ 34ms
Jul 06 09:52:22 localhost volumio[18137]: info:
Jul 06 09:52:22 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:22 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:22 localhost volumio[18137]: info:
Jul 06 09:52:22 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:22 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:22 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 28 milliseconds
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:22 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:22 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:22 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"离别开出花(弹唱版)","artist":"就是南方凯","album":"离别开出花(弹唱版)","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000025TjRq1JLmOa.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=DAB4333BA0E3577102A8300BF6B37CAF82073292A10A93C8F317405E9ECB076280191A6A615AE916215D34B8507AA29CCDB046BCB67727A2&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:22 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus play
Jul 06 09:52:22 localhost volumio[18137]: info: Received an update from plugin. extracting info from payload
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:22 localhost volumio[18137]: info: ------------------------------ 69ms
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: ------------------------------ 66ms
Jul 06 09:52:22 localhost volumio[18137]: info: sendMpdCommand status took 66 milliseconds
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:22 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jul 06 09:52:22 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:22 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:22 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:22 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"离别开出花(弹唱版)","artist":"就是南方凯","album":"离别开出花(弹唱版)","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000025TjRq1JLmOa.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=DAB4333BA0E3577102A8300BF6B37CAF82073292A10A93C8F317405E9ECB076280191A6A615AE916215D34B8507AA29CCDB046BCB67727A2&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:22 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus play
Jul 06 09:52:22 localhost volumio[18137]: info: Received an update from plugin. extracting info from payload
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:22 localhost volumio[18137]: info: ------------------------------ 130ms
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:22 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:27 localhost volumio[18137]: info: Clearing queue after UPNP request
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::ClearQueue
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::stop
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 06 09:52:28 localhost volumio[18137]: UNSET VOLATILE
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::stPlaybackTimer
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::updateTrackBlock
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::getTrackBlock
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::serviceStop
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:28 localhost volumio[18137]: info: ControllerMpd::stop
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand stop
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::clearPlayQueue
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::saveQueue
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::volumioPushQueue
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:28 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:28 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:28 localhost volumio[18137]: info: sendMpdCommand stop took 60 milliseconds
Jul 06 09:52:28 localhost volumio[18137]: error: updateQueue error: null
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 21ms
Jul 06 09:52:28 localhost volumio[18137]: info: sendMpdCommand status took 7 milliseconds
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:28 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:28 localhost volumio[18137]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 06 09:52:28 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::syncState stateService stop
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:28 localhost volumio[18137]: info: No code
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 74ms
Jul 06 09:52:28 localhost volumio[18137]: info: Starting UPNP Playback
Jul 06 09:52:28 localhost volumio[18137]: info: Preparing playback through UPNP
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::volumioGetState
Jul 06 09:52:28 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:28 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 06 09:52:28 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:28 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:28 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:28 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:28 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:28 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:28 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:28 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:28 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:28 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:28 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:28 localhost volumio[18137]: info:
Jul 06 09:52:28 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:28 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:28 localhost volumio[18137]: info: sendMpdCommand status took 5 milliseconds
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:28 localhost volumio[18137]: info: ------------------------------ 5ms
Jul 06 09:52:28 localhost volumio[18137]: info: sendMpdCommand status took 4 milliseconds
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:28 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 06 09:52:28 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:28 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:28 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:28 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:28 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:29 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"离别开出花_MMM","artist":"杨坤/吉克隽逸","album":"天赐的声音第五季 第1期","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000P0hKT2Qrm9l.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=752C46E86754010026C84D53A13F9677FAD49F5EBF978CA0B768B917C33F495B6C9721BEB620818F472653647D94A300F49338C40187D397&uin=1152921504861845851&src=M500002s56HW2U2sBN.mp3&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:29 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:29 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:29 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:29 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"离别开出花_MMM","artist":"杨坤/吉克隽逸","album":"天赐的声音第五季 第1期","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000P0hKT2Qrm9l.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=752C46E86754010026C84D53A13F9677FAD49F5EBF978CA0B768B917C33F495B6C9721BEB620818F472653647D94A300F49338C40187D397&uin=1152921504861845851&src=M500002s56HW2U2sBN.mp3&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:29 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus play
Jul 06 09:52:29 localhost volumio[18137]: info: Received an update from plugin. extracting info from payload
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:29 localhost volumio[18137]: info: ------------------------------ 93ms
Jul 06 09:52:29 localhost volumio[18137]: info: ------------------------------ 88ms
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:29 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:29 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:29 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:29 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:29 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:31 localhost volumio[18137]: info: Clearing queue after UPNP request
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::ClearQueue
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::stop
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 06 09:52:32 localhost volumio[18137]: UNSET VOLATILE
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::stPlaybackTimer
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::updateTrackBlock
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::getTrackBlock
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::serviceStop
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:32 localhost volumio[18137]: info: ControllerMpd::stop
Jul 06 09:52:32 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand stop
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::clearPlayQueue
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::saveQueue
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::volumioPushQueue
Jul 06 09:52:32 localhost volumio[18137]: info:
Jul 06 09:52:32 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:32 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:32 localhost volumio[18137]: info:
Jul 06 09:52:32 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:32 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:32 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:32 localhost volumio[18137]: info: sendMpdCommand stop took 90 milliseconds
Jul 06 09:52:32 localhost volumio[18137]: error: updateQueue error: null
Jul 06 09:52:32 localhost volumio[18137]: info: ------------------------------ 6ms
Jul 06 09:52:32 localhost volumio[18137]: info: sendMpdCommand status took 5 milliseconds
Jul 06 09:52:32 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:32 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:32 localhost volumio[18137]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 06 09:52:32 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::syncState stateService stop
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:32 localhost volumio[18137]: info: No code
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:32 localhost volumio[18137]: info: ------------------------------ 59ms
Jul 06 09:52:32 localhost volumio[18137]: info: Starting UPNP Playback
Jul 06 09:52:32 localhost volumio[18137]: info: Preparing playback through UPNP
Jul 06 09:52:32 localhost volumio[18137]: info: CoreCommandRouter::volumioGetState
Jul 06 09:52:32 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:32 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 06 09:52:32 localhost volumio[18137]: info:
Jul 06 09:52:32 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:32 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:32 localhost volumio[18137]: info:
Jul 06 09:52:32 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:32 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:32 localhost volumio[18137]: info: ------------------------------ 4ms
Jul 06 09:52:32 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:32 localhost volumio[18137]: info:
Jul 06 09:52:32 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:32 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:32 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:32 localhost volumio[18137]: info:
Jul 06 09:52:32 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:32 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:32 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:32 localhost volumio[18137]: info:
Jul 06 09:52:32 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:32 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:32 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:32 localhost volumio[18137]: info:
Jul 06 09:52:32 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:32 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:32 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:33 localhost volumio[18137]: info:
Jul 06 09:52:33 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:33 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:33 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:33 localhost volumio[18137]: info: sendMpdCommand status took 7 milliseconds
Jul 06 09:52:33 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:33 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:33 localhost volumio[18137]: info:
Jul 06 09:52:33 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:33 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:33 localhost volumio[18137]: info:
Jul 06 09:52:33 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:33 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:33 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:33 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 06 09:52:33 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:33 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:33 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:33 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":308,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"和你一样","artist":"李宇春","album":"N+1 Evolution","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000017wVSw4digsU.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=9868E0A9AD1FAAD5D935FEC01983FAFF4C2D544AAF35F4BD02F32685D03C8E1D38038C1601873E073AC43801A7384BF81FE42F5723A92F86&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:33 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:33 localhost volumio[18137]: info: ------------------------------ 45ms
Jul 06 09:52:33 localhost volumio[18137]: info: ------------------------------ 37ms
Jul 06 09:52:33 localhost volumio[18137]: info: sendMpdCommand status took 41 milliseconds
Jul 06 09:52:33 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:33 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:33 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:33 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jul 06 09:52:33 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:33 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:33 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:33 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":308,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"和你一样","artist":"李宇春","album":"N+1 Evolution","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000017wVSw4digsU.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=9868E0A9AD1FAAD5D935FEC01983FAFF4C2D544AAF35F4BD02F32685D03C8E1D38038C1601873E073AC43801A7384BF81FE42F5723A92F86&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:33 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus play
Jul 06 09:52:33 localhost volumio[18137]: info: Received an update from plugin. extracting info from payload
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:33 localhost volumio[18137]: info: ------------------------------ 129ms
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:33 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:33 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:33 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:33 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:38 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:38 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:38 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:42 localhost volumio[18137]: info: Clearing queue after UPNP request
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::ClearQueue
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::stop
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 06 09:52:42 localhost volumio[18137]: UNSET VOLATILE
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::stPlaybackTimer
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::updateTrackBlock
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::getTrackBlock
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::serviceStop
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:42 localhost volumio[18137]: info: ControllerMpd::stop
Jul 06 09:52:42 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand stop
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::clearPlayQueue
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::saveQueue
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::volumioPushQueue
Jul 06 09:52:42 localhost volumio[18137]: info:
Jul 06 09:52:42 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:42 localhost volumio[18137]: info: sendMpdCommand stop took 76 milliseconds
Jul 06 09:52:42 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:42 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:42 localhost volumio[18137]: info:
Jul 06 09:52:42 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:42 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:42 localhost volumio[18137]: info: sendMpdCommand status took 3 milliseconds
Jul 06 09:52:42 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:42 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:42 localhost volumio[18137]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 06 09:52:42 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::syncState stateService stop
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:42 localhost volumio[18137]: info: No code
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:42 localhost volumio[18137]: info: ------------------------------ 36ms
Jul 06 09:52:42 localhost volumio[18137]: info: Starting UPNP Playback
Jul 06 09:52:42 localhost volumio[18137]: info: Preparing playback through UPNP
Jul 06 09:52:42 localhost volumio[18137]: info: CoreCommandRouter::volumioGetState
Jul 06 09:52:42 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:42 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 06 09:52:42 localhost volumio[18137]: error: updateQueue error: null
Jul 06 09:52:42 localhost volumio[18137]: info: ------------------------------ 36ms
Jul 06 09:52:42 localhost volumio[18137]: info:
Jul 06 09:52:42 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:42 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:42 localhost volumio[18137]: info:
Jul 06 09:52:42 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:42 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:42 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:42 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:42 localhost volumio[18137]: info:
Jul 06 09:52:42 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:42 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:42 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:42 localhost volumio[18137]: info:
Jul 06 09:52:42 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:42 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:42 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:42 localhost volumio[18137]: info:
Jul 06 09:52:42 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:42 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:42 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:42 localhost volumio[18137]: info:
Jul 06 09:52:42 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:42 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:42 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:43 localhost volumio[18137]: info:
Jul 06 09:52:43 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:43 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:43 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:43 localhost volumio[18137]: info:
Jul 06 09:52:43 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:43 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:43 localhost volumio[18137]: info:
Jul 06 09:52:43 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:43 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:43 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:43 localhost volumio[18137]: info: sendMpdCommand status took 6 milliseconds
Jul 06 09:52:43 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:43 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:43 localhost volumio[18137]: info: ------------------------------ 9ms
Jul 06 09:52:43 localhost volumio[18137]: info: sendMpdCommand status took 10 milliseconds
Jul 06 09:52:43 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jul 06 09:52:43 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:43 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:43 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:43 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:43 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:43 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"字字句句","artist":"张碧晨","album":"天赐的声音第四季 第3期","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500001rw4YQ1phDiB.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=4A751182E54E92071AB31336BADB1A74DEA275E3ACDADDDC0A2B897A98FA1A92D2C22CBBE11B5FA855864693122DDCFDAAF634D9F4B9FEE2&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:43 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:43 localhost volumio[18137]: info: ------------------------------ 42ms
Jul 06 09:52:43 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 26 milliseconds
Jul 06 09:52:43 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:43 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:43 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:43 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":292,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"字字句句","artist":"张碧晨","album":"天赐的声音第四季 第3期","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500001rw4YQ1phDiB.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=4A751182E54E92071AB31336BADB1A74DEA275E3ACDADDDC0A2B897A98FA1A92D2C22CBBE11B5FA855864693122DDCFDAAF634D9F4B9FEE2&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:43 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus play
Jul 06 09:52:43 localhost volumio[18137]: info: Received an update from plugin. extracting info from payload
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:43 localhost volumio[18137]: info: ------------------------------ 80ms
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:43 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:43 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:43 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:43 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:43 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:48 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:48 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:48 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:49 localhost volumio[18137]: info: Clearing queue after UPNP request
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::ClearQueue
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::stop
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 06 09:52:50 localhost volumio[18137]: UNSET VOLATILE
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::stPlaybackTimer
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::updateTrackBlock
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::getTrackBlock
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::serviceStop
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:50 localhost volumio[18137]: info: ControllerMpd::stop
Jul 06 09:52:50 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand stop
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::clearPlayQueue
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::saveQueue
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::volumioPushQueue
Jul 06 09:52:50 localhost volumio[18137]: info:
Jul 06 09:52:50 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:50 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:50 localhost volumio[18137]: info:
Jul 06 09:52:50 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:50 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:50 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:50 localhost volumio[18137]: info: sendMpdCommand stop took 159 milliseconds
Jul 06 09:52:50 localhost volumio[18137]: error: updateQueue error: null
Jul 06 09:52:50 localhost volumio[18137]: info: ------------------------------ 31ms
Jul 06 09:52:50 localhost volumio[18137]: info: sendMpdCommand status took 11 milliseconds
Jul 06 09:52:50 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:50 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:50 localhost volumio[18137]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 06 09:52:50 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::syncState stateService stop
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:50 localhost volumio[18137]: info: No code
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:50 localhost volumio[18137]: info: ------------------------------ 79ms
Jul 06 09:52:50 localhost volumio[18137]: info: Starting UPNP Playback
Jul 06 09:52:50 localhost volumio[18137]: info: Preparing playback through UPNP
Jul 06 09:52:50 localhost volumio[18137]: info: CoreCommandRouter::volumioGetState
Jul 06 09:52:50 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:50 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 06 09:52:50 localhost volumio[18137]: info:
Jul 06 09:52:50 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:50 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:50 localhost volumio[18137]: info:
Jul 06 09:52:50 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:50 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:50 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:50 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:50 localhost volumio[18137]: info:
Jul 06 09:52:50 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:50 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:50 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:50 localhost volumio[18137]: info:
Jul 06 09:52:50 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:50 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:50 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:50 localhost volumio[18137]: info:
Jul 06 09:52:50 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:50 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:50 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:50 localhost volumio[18137]: info:
Jul 06 09:52:50 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:50 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:50 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:51 localhost volumio[18137]: info:
Jul 06 09:52:51 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:51 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:51 localhost volumio[18137]: info:
Jul 06 09:52:51 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:51 localhost volumio[18137]: info: sendMpdCommand status took 8 milliseconds
Jul 06 09:52:51 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:51 localhost volumio[18137]: info:
Jul 06 09:52:51 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:51 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:51 localhost volumio[18137]: info:
Jul 06 09:52:51 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:51 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:51 localhost volumio[18137]: info: sendMpdCommand status took 9 milliseconds
Jul 06 09:52:51 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:51 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:51 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:51 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":153,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"南方的小土豆","artist":"宋盐球","album":"南方的小土豆","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000036X20q0LCuQW.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=784869007722230CD1871590CCE0B965335724B9F611C4F0095B7134EF7426E5B00AF45AECA5103AC43AE456CFB8903046CEF0A4855E81E0&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:51 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:51 localhost volumio[18137]: info: ------------------------------ 45ms
Jul 06 09:52:51 localhost volumio[18137]: info: ------------------------------ 35ms
Jul 06 09:52:51 localhost volumio[18137]: info: sendMpdCommand status took 47 milliseconds
Jul 06 09:52:51 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 40 milliseconds
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:51 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:51 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:51 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81,"duration":153,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"南方的小土豆","artist":"宋盐球","album":"南方的小土豆","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000036X20q0LCuQW.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=784869007722230CD1871590CCE0B965335724B9F611C4F0095B7134EF7426E5B00AF45AECA5103AC43AE456CFB8903046CEF0A4855E81E0&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:51 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus play
Jul 06 09:52:51 localhost volumio[18137]: info: Received an update from plugin. extracting info from payload
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:51 localhost volumio[18137]: info: ------------------------------ 92ms
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 71 milliseconds
Jul 06 09:52:51 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:52:51 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:51 localhost volumio[18137]: In UPNP mode
Jul 06 09:52:51 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":153,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"南方的小土豆","artist":"宋盐球","album":"南方的小土豆","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000036X20q0LCuQW.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=784869007722230CD1871590CCE0B965335724B9F611C4F0095B7134EF7426E5B00AF45AECA5103AC43AE456CFB8903046CEF0A4855E81E0&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:52:51 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus play
Jul 06 09:52:51 localhost volumio[18137]: info: Received an update from plugin. extracting info from payload
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:51 localhost volumio[18137]: info: ------------------------------ 162ms
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:51 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:58 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:58 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:58 localhost avahi-daemon[609]: Received response from host 192.168.3.160 with invalid source port 43071 on interface 'eth0.0'
Jul 06 09:52:58 localhost volumio[18137]: info: Clearing queue after UPNP request
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::ClearQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::stop
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 06 09:52:59 localhost volumio[18137]: UNSET VOLATILE
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::stPlaybackTimer
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::updateTrackBlock
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::getTrackBlock
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::serviceStop
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:59 localhost volumio[18137]: info: ControllerMpd::stop
Jul 06 09:52:59 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand stop
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::clearPlayQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::saveQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioPushQueue
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:59 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:59 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:59 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:59 localhost volumio[18137]: info: sendMpdCommand stop took 107 milliseconds
Jul 06 09:52:59 localhost volumio[18137]: info: Starting UPNP Playback
Jul 06 09:52:59 localhost volumio[18137]: info: Preparing playback through UPNP
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioGetState
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 06 09:52:59 localhost volumio[18137]: error: updateQueue error: null
Jul 06 09:52:59 localhost volumio[18137]: info: ------------------------------ 13ms
Jul 06 09:52:59 localhost volumio[18137]: info: sendMpdCommand status took 11 milliseconds
Jul 06 09:52:59 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:52:59 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::getTrack 0
Jul 06 09:52:59 localhost volumio[18137]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 06 09:52:59 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::syncState stateService stop
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:59 localhost volumio[18137]: info: No code
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:52:59 localhost volumio[18137]: info: ------------------------------ 70ms
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:52:59 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:59 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:59 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:59 localhost volumio[18137]: info: ------------------------------ 4ms
Jul 06 09:52:59 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:59 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:59 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:59 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:59 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:59 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:59 localhost volumio[18137]: info: ------------------------------ 2ms
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:59 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:59 localhost volumio[18137]: info: ------------------------------ 3ms
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:59 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:52:59 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces system playlist update
Jul 06 09:52:59 localhost volumio[18137]: info: Ignoring MPD Status Update
Jul 06 09:52:59 localhost volumio[18137]: info:
Jul 06 09:52:59 localhost volumio[18137]: ---------------------------- MPD announces state update: player
Jul 06 09:52:59 localhost volumio[18137]: info: sendMpdCommand status took 9 milliseconds
Jul 06 09:53:00 localhost volumio[18137]: info: ControllerMpd::getState
Jul 06 09:53:00 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand status
Jul 06 09:53:00 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:53:00 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:53:00 localhost volumio[18137]: info: ------------------------------ 10ms
Jul 06 09:53:00 localhost volumio[18137]: info: sendMpdCommand status took 8 milliseconds
Jul 06 09:53:00 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jul 06 09:53:00 localhost volumio[18137]: verbose: ControllerMpd::parseState
Jul 06 09:53:00 localhost volumio[18137]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 06 09:53:00 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:53:00 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:53:00 localhost volumio[18137]: In UPNP mode
Jul 06 09:53:00 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":164,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"帽衫(完整版)","artist":"王搏","album":"帽衫(完整版)","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500003c7g6y4KuYoo.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=B49D97FEB12ACFC43C05DD481789322E50A608E5895C161915AF6B08C46252E06179F7276713794804624D82FBC0DE316E8B00C7D36A4196&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:53:00 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus stop
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:53:00 localhost volumio[18137]: info: ------------------------------ 53ms
Jul 06 09:53:00 localhost volumio[18137]: info: sendMpdCommand playlistinfo took 35 milliseconds
Jul 06 09:53:00 localhost volumio[18137]: verbose: ControllerMpd::parseTrackInfo
Jul 06 09:53:00 localhost volumio[18137]: info: ControllerMpd::pushState
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::servicePushState
Jul 06 09:53:00 localhost volumio[18137]: In UPNP mode
Jul 06 09:53:00 localhost volumio[18137]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":164,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"帽衫(完整版)","artist":"王搏","album":"帽衫(完整版)","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500003c7g6y4KuYoo.mp3?guid=70D27AFEBC8747DF948FD5D1DE7AFA42&vkey=B49D97FEB12ACFC43C05DD481789322E50A608E5895C161915AF6B08C46252E06179F7276713794804624D82FBC0DE316E8B00C7D36A4196&uin=1152921504861845851&redirect=1&fromtag=101042","trackType":""}
Jul 06 09:53:00 localhost volumio[18137]: verbose: CURRENT POSITION 0
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::syncState stateService play
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::syncState currentStatus play
Jul 06 09:53:00 localhost volumio[18137]: info: Received an update from plugin. extracting info from payload
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::pushState
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::volumioPushState
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 06 09:53:00 localhost volumio[18137]: info: ------------------------------ 75ms
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:53:00 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:53:00 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:53:00 localhost volumio[18137]: info: CoreCommandRouter::volumioGetQueue
Jul 06 09:53:00 localhost volumio[18137]: info: CoreStateMachine::getQueue
Jul 06 09:53:00 localhost volumio[18137]: info: CorePlayQueue::getQueue
Jul 06 09:53:03 localhost volumio[18137]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 06 09:53:03 localhost volumio[18137]: { Error: connect ETIMEDOUT 31.13.75.5:443
Jul 06 09:53:03 localhost volumio[18137]: at Object._errnoException (util.js:1022:11)
Jul 06 09:53:03 localhost volumio[18137]: at _exceptionWithHostPort (util.js:1044:20)
Jul 06 09:53:03 localhost volumio[18137]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Jul 06 09:53:03 localhost volumio[18137]: code: 'ETIMEDOUT',
Jul 06 09:53:03 localhost volumio[18137]: errno: 'ETIMEDOUT',
Jul 06 09:53:03 localhost volumio[18137]: syscall: 'connect',
Jul 06 09:53:03 localhost volumio[18137]: address: '31.13.75.5',
Jul 06 09:53:03 localhost volumio[18137]: port: 443 }
Jul 06 09:53:03 localhost volumio[18137]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 06 09:53:04 localhost sudo[23307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-06 09:52
Jul 06 09:53:04 localhost sudo[23307]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="e81b2037a65d8f554cb0c857a1007d659ad7f838"
VOLUMIO_FE_VERSION="e489037accd8e0b2dcbd6e0b054400d8cd36d4e2"
VOLUMIO_BE_VERSION="25875b197c75cd1ac7eb5664d94cdd19afb06985"
VOLUMIO_ARCH="x86"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Feb 19 17:57:53 CET 2021"
VOLUMIO_VERSION="2.873"
VOLUMIO_HARDWARE="x86"
VOLUMIO_HASH="aa20cea461a8f0bd689fe0d5d2a83194"