-- Logs begin at Fri 2024-07-05 01:31:56 UTC, end at Fri 2024-07-05 02:05:51 UTC. --
Jul 05 02:04:00 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:00 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:10 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:10 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:10 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:20 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:20 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:20 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:21 localhost volumio[3745]: info:
Jul 05 02:04:21 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:21 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:21 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:21 localhost volumio[3745]: info: sendMpdCommand status took 3 milliseconds
Jul 05 02:04:21 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:21 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:21 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 05 02:04:21 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:21 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:21 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:21 localhost volumio[3745]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我们的故事","artist":"光良","album":"回忆里的疯狂","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500001ibR9P0WTfga.mp3?guid=ffffffffe5264219000001907177e797&vkey=683F9DD7DB4D7C2665A273495BCE0B37AA52BA7A8F74F4DBD32841AF432F95E95BD6497AD7203886D2B543509B75627FDE26ECE84CE96196&uin=&src=M500003Wr0nc0fUfiG.mp3&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:21 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::syncState stateService stop
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::play index undefined
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:21 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:21 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:21 localhost volumio[3745]: info: ------------------------------ 34ms
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:04:21 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:04:21 localhost volumio[3745]: info: Clearing queue after UPNP request
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::ClearQueue
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::stop
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:21 localhost volumio[3745]: UNSET VOLATILE
Jul 05 02:04:21 localhost volumio[3745]: info: CorePlayQueue::clearPlayQueue
Jul 05 02:04:21 localhost volumio[3745]: info: CorePlayQueue::saveQueue
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::volumioPushQueue
Jul 05 02:04:21 localhost volumio[3745]: info:
Jul 05 02:04:21 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:21 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:21 localhost volumio[3745]: error: updateQueue error: null
Jul 05 02:04:21 localhost volumio[3745]: info: ------------------------------ 9ms
Jul 05 02:04:21 localhost volumio[3745]: info: Starting UPNP Playback
Jul 05 02:04:21 localhost volumio[3745]: info: Preparing playback through UPNP
Jul 05 02:04:21 localhost volumio[3745]: info: CoreCommandRouter::volumioGetState
Jul 05 02:04:21 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:21 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:22 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 7ms
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:22 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:22 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 8ms
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:22 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 7ms
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:22 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:22 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 5ms
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 4ms
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:22 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:22 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:22 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:22 localhost volumio[3745]: info:
Jul 05 02:04:22 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:22 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:22 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:22 localhost volumio[3745]: info: sendMpdCommand status took 6 milliseconds
Jul 05 02:04:22 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:22 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 6ms
Jul 05 02:04:22 localhost volumio[3745]: info: sendMpdCommand status took 4 milliseconds
Jul 05 02:04:22 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 05 02:04:22 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:22 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:22 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:22 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:22 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:22 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":69,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包 (死亡金属版)","artist":"鄙是阎钰","album":null,"uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500001TLpAj4LVet3.mp3?guid=ffffffffe5264219000001907177e797&vkey=F84D5F8624BAD52C26CD3A9252EFAF4DE0E04B0F0C542DB122B396F95D36952F6858419C5ED0B3637F22B77C1EFACA2886BB64120A05D489&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:22 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:22 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:22 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus stop
Jul 05 02:04:22 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 35ms
Jul 05 02:04:22 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jul 05 02:04:22 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:22 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:22 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:22 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":69,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包 (死亡金属版)","artist":"鄙是阎钰","album":null,"uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500001TLpAj4LVet3.mp3?guid=ffffffffe5264219000001907177e797&vkey=F84D5F8624BAD52C26CD3A9252EFAF4DE0E04B0F0C542DB122B396F95D36952F6858419C5ED0B3637F22B77C1EFACA2886BB64120A05D489&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:22 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:22 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:22 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:22 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:04:22 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:22 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:22 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:22 localhost volumio[3745]: info: ------------------------------ 60ms
Jul 05 02:04:22 localhost volumio[3745]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%85%89%E8%89%AF/%E5%9B%9E%E5%BF%86%E9%87%8C%E7%9A%84%E7%96%AF%E7%8B%82/d97a03d7-23d2-4075-81b4-d25972015621.png'
Jul 05 02:04:24 localhost volumio[3745]: info:
Jul 05 02:04:24 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:24 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:24 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:24 localhost volumio[3745]: info: sendMpdCommand status took 2 milliseconds
Jul 05 02:04:24 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:24 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:24 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jul 05 02:04:24 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:24 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:24 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:24 localhost volumio[3745]: 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":"http://116.31.98.36/amobile.music.tc.qq.com/M500001TLpAj4LVet3.mp3?guid=ffffffffe5264219000001907177e797&vkey=F84D5F8624BAD52C26CD3A9252EFAF4DE0E04B0F0C542DB122B396F95D36952F6858419C5ED0B3637F22B77C1EFACA2886BB64120A05D489&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:24 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::syncState stateService stop
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::play index undefined
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:24 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:24 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:24 localhost volumio[3745]: info: ------------------------------ 66ms
Jul 05 02:04:24 localhost volumio[3745]: info: Clearing queue after UPNP request
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::ClearQueue
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::stop
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:24 localhost volumio[3745]: UNSET VOLATILE
Jul 05 02:04:24 localhost volumio[3745]: info: CorePlayQueue::clearPlayQueue
Jul 05 02:04:24 localhost volumio[3745]: info: CorePlayQueue::saveQueue
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::volumioPushQueue
Jul 05 02:04:24 localhost volumio[3745]: info:
Jul 05 02:04:24 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:24 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:24 localhost volumio[3745]: error: updateQueue error: null
Jul 05 02:04:24 localhost volumio[3745]: info: ------------------------------ 10ms
Jul 05 02:04:24 localhost volumio[3745]: info: Starting UPNP Playback
Jul 05 02:04:24 localhost volumio[3745]: info: Preparing playback through UPNP
Jul 05 02:04:24 localhost volumio[3745]: info: CoreCommandRouter::volumioGetState
Jul 05 02:04:24 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:24 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:25 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:25 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 4ms
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:25 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 4ms
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:25 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:25 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:25 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:25 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:25 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:25 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:25 localhost volumio[3745]: info:
Jul 05 02:04:25 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:25 localhost volumio[3745]: info: sendMpdCommand status took 3 milliseconds
Jul 05 02:04:25 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:25 localhost volumio[3745]: info: sendMpdCommand status took 4 milliseconds
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 6ms
Jul 05 02:04:25 localhost volumio[3745]: info: sendMpdCommand status took 13 milliseconds
Jul 05 02:04:25 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jul 05 02:04:25 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:25 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:25 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:25 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":20,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包","artist":"胖胖的恶魔","album":null,"uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000014YduR3cPaDT.mp3?guid=ffffffffe5264219000001907177e797&vkey=8AF15BB4B1A516694ECDD57CA59B5DB0ADDE5C6BE63429F61B9F8958E08563756F76500CDED7B30E25E4182F007D799696DA81652B4993C8&uin=&src=M5000040fekv3GvNtS.mp3&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:25 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus stop
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:25 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:25 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:25 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":20,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包","artist":"胖胖的恶魔","album":null,"uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000014YduR3cPaDT.mp3?guid=ffffffffe5264219000001907177e797&vkey=8AF15BB4B1A516694ECDD57CA59B5DB0ADDE5C6BE63429F61B9F8958E08563756F76500CDED7B30E25E4182F007D799696DA81652B4993C8&uin=&src=M5000040fekv3GvNtS.mp3&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:25 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:25 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 88ms
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 82ms
Jul 05 02:04:25 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 74 milliseconds
Jul 05 02:04:25 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:25 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:25 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:25 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":20,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包","artist":"胖胖的恶魔","album":null,"uri":"http://116.31.98.36/amobile.music.tc.qq.com/M5000014YduR3cPaDT.mp3?guid=ffffffffe5264219000001907177e797&vkey=8AF15BB4B1A516694ECDD57CA59B5DB0ADDE5C6BE63429F61B9F8958E08563756F76500CDED7B30E25E4182F007D799696DA81652B4993C8&uin=&src=M5000040fekv3GvNtS.mp3&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:25 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:25 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:25 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:25 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:25 localhost volumio[3745]: info: ------------------------------ 136ms
Jul 05 02:04:30 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:30 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:31 localhost volumio[3745]: info:
Jul 05 02:04:31 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:31 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:31 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:31 localhost volumio[3745]: info: sendMpdCommand status took 2 milliseconds
Jul 05 02:04:31 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:31 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:31 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 05 02:04:31 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:31 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:31 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:31 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:31 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:31 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:31 localhost volumio[3745]: 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":"http://116.31.98.36/amobile.music.tc.qq.com/M5000014YduR3cPaDT.mp3?guid=ffffffffe5264219000001907177e797&vkey=8AF15BB4B1A516694ECDD57CA59B5DB0ADDE5C6BE63429F61B9F8958E08563756F76500CDED7B30E25E4182F007D799696DA81652B4993C8&uin=&src=M5000040fekv3GvNtS.mp3&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:31 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::syncState stateService stop
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::play index undefined
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:31 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:31 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:31 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:31 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:31 localhost volumio[3745]: info: ------------------------------ 38ms
Jul 05 02:04:31 localhost volumio[3745]: info: Clearing queue after UPNP request
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::ClearQueue
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::stop
Jul 05 02:04:31 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:31 localhost volumio[3745]: UNSET VOLATILE
Jul 05 02:04:31 localhost volumio[3745]: info: CorePlayQueue::clearPlayQueue
Jul 05 02:04:32 localhost volumio[3745]: info: CorePlayQueue::saveQueue
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::volumioPushQueue
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:32 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:32 localhost volumio[3745]: error: updateQueue error: null
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 9ms
Jul 05 02:04:32 localhost volumio[3745]: info: Starting UPNP Playback
Jul 05 02:04:32 localhost volumio[3745]: info: Preparing playback through UPNP
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::volumioGetState
Jul 05 02:04:32 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:32 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:32 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:32 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 4ms
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:32 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 8ms
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:32 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 5ms
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:32 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:32 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:32 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:32 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:32 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:32 localhost volumio[3745]: info:
Jul 05 02:04:32 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:32 localhost volumio[3745]: info: sendMpdCommand status took 8 milliseconds
Jul 05 02:04:32 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:32 localhost volumio[3745]: info: sendMpdCommand status took 19 milliseconds
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 17ms
Jul 05 02:04:32 localhost volumio[3745]: info: sendMpdCommand status took 4 milliseconds
Jul 05 02:04:32 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:32 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:32 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:32 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":79,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包","artist":"DJ金旭","album":"紫米面包","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000jdtPN4IOMJg.mp3?guid=ffffffffe5264219000001907177e797&vkey=F87A3FE832E9D53642EE7420EB0C5782513AD8E7BD05A9FCBA1030D9C85996896436C6BCD3569D628154AA68B526AD4EA9FB1F10559A4681&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:32 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:32 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:32 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus stop
Jul 05 02:04:32 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:32 localhost volumio[3745]: info: ------------------------------ 55ms
Jul 05 02:04:32 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 30 milliseconds
Jul 05 02:04:32 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 30 milliseconds
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:32 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:32 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:32 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:32 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":79,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包","artist":"DJ金旭","album":"紫米面包","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000jdtPN4IOMJg.mp3?guid=ffffffffe5264219000001907177e797&vkey=F87A3FE832E9D53642EE7420EB0C5782513AD8E7BD05A9FCBA1030D9C85996896436C6BCD3569D628154AA68B526AD4EA9FB1F10559A4681&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:32 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:32 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:32 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:32 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:04:32 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:32 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:32 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:32 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:32 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:32 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":79,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包","artist":"DJ金旭","album":"紫米面包","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000jdtPN4IOMJg.mp3?guid=ffffffffe5264219000001907177e797&vkey=F87A3FE832E9D53642EE7420EB0C5782513AD8E7BD05A9FCBA1030D9C85996896436C6BCD3569D628154AA68B526AD4EA9FB1F10559A4681&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:33 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:33 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:33 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:33 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:04:33 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:33 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:33 localhost volumio[3745]: info: ------------------------------ 147ms
Jul 05 02:04:33 localhost volumio[3745]: info: ------------------------------ 146ms
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:04:33 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:04:35 localhost volumio[3745]: info:
Jul 05 02:04:35 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:35 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:35 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:35 localhost volumio[3745]: info: sendMpdCommand status took 2 milliseconds
Jul 05 02:04:35 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:35 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:35 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 05 02:04:35 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:35 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:35 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:35 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:35 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:35 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:35 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:35 localhost volumio[3745]: 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":"DJ金旭","album":"紫米面包","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000jdtPN4IOMJg.mp3?guid=ffffffffe5264219000001907177e797&vkey=F87A3FE832E9D53642EE7420EB0C5782513AD8E7BD05A9FCBA1030D9C85996896436C6BCD3569D628154AA68B526AD4EA9FB1F10559A4681&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:35 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:35 localhost volumio[3745]: info: CoreStateMachine::syncState stateService stop
Jul 05 02:04:35 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:35 localhost volumio[3745]: info: CoreStateMachine::play index undefined
Jul 05 02:04:35 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:35 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:35 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:36 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:36 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:36 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:36 localhost volumio[3745]: info: ------------------------------ 64ms
Jul 05 02:04:36 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:04:36 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:04:36 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:04:36 localhost volumio[3745]: info: Clearing queue after UPNP request
Jul 05 02:04:36 localhost volumio[3745]: info: CoreStateMachine::ClearQueue
Jul 05 02:04:36 localhost volumio[3745]: info: CoreStateMachine::stop
Jul 05 02:04:36 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:36 localhost volumio[3745]: UNSET VOLATILE
Jul 05 02:04:36 localhost volumio[3745]: info: CorePlayQueue::clearPlayQueue
Jul 05 02:04:36 localhost volumio[3745]: info: CorePlayQueue::saveQueue
Jul 05 02:04:36 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:36 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:36 localhost volumio[3745]: info: CoreCommandRouter::volumioPushQueue
Jul 05 02:04:36 localhost volumio[3745]: info:
Jul 05 02:04:36 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:36 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:36 localhost volumio[3745]: error: updateQueue error: null
Jul 05 02:04:36 localhost volumio[3745]: info: ------------------------------ 4ms
Jul 05 02:04:36 localhost volumio[3745]: info: Starting UPNP Playback
Jul 05 02:04:36 localhost volumio[3745]: info: Preparing playback through UPNP
Jul 05 02:04:36 localhost volumio[3745]: info: CoreCommandRouter::volumioGetState
Jul 05 02:04:36 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:36 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 05 02:04:36 localhost volumio[3745]: info:
Jul 05 02:04:36 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:36 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:36 localhost volumio[3745]: info:
Jul 05 02:04:36 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:36 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:36 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:36 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:04:36 localhost volumio[3745]: info:
Jul 05 02:04:36 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:36 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:36 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:04:36 localhost volumio[3745]: info:
Jul 05 02:04:36 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:36 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:36 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:04:36 localhost volumio[3745]: info:
Jul 05 02:04:36 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:36 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:36 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:04:36 localhost volumio[3745]: info:
Jul 05 02:04:36 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:36 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:36 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:04:37 localhost volumio[3745]: info:
Jul 05 02:04:37 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:37 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:37 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:37 localhost volumio[3745]: info: sendMpdCommand status took 2 milliseconds
Jul 05 02:04:37 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:37 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:37 localhost volumio[3745]: info:
Jul 05 02:04:37 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:37 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:37 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:37 localhost volumio[3745]: info:
Jul 05 02:04:37 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:37 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:37 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 05 02:04:37 localhost volumio[3745]: info: sendMpdCommand status took 3 milliseconds
Jul 05 02:04:37 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:37 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:37 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:37 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:37 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:37 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":16,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包 (片段)","artist":"网络歌手","album":null,"uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500001hqJKZ119ITg.mp3?guid=ffffffffe5264219000001907177e797&vkey=456C7BB0368262EC76007E09195866EA4AB39A13D026F1EFAC0DDBB236F0429359F843624A14FB1F3AA539B2B7C6DF6636CFA2FB6C672821&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:37 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:37 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:37 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus stop
Jul 05 02:04:37 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:37 localhost volumio[3745]: info: ------------------------------ 34ms
Jul 05 02:04:37 localhost volumio[3745]: info: ------------------------------ 35ms
Jul 05 02:04:37 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jul 05 02:04:37 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:37 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:37 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:37 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":16,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包 (片段)","artist":"网络歌手","album":null,"uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500001hqJKZ119ITg.mp3?guid=ffffffffe5264219000001907177e797&vkey=456C7BB0368262EC76007E09195866EA4AB39A13D026F1EFAC0DDBB236F0429359F843624A14FB1F3AA539B2B7C6DF6636CFA2FB6C672821&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:37 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:37 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:37 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:37 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:04:37 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:37 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:37 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:37 localhost volumio[3745]: info: ------------------------------ 61ms
Jul 05 02:04:40 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:40 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:40 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:50 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:50 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:50 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:04:52 localhost volumio[3745]: info:
Jul 05 02:04:52 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:52 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:52 localhost volumio[3745]: info:
Jul 05 02:04:52 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:52 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:52 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:52 localhost volumio[3745]: info: ------------------------------ 8ms
Jul 05 02:04:52 localhost volumio[3745]: info: sendMpdCommand status took 5 milliseconds
Jul 05 02:04:52 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:52 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:52 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 05 02:04:52 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:52 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:52 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:52 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:52 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15487,"duration":16,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"×ÏÃ×Ãæ°ü (Ƭ¶Î)","artist":"ÍøÂç¸èÊÖ","album":null,"uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500001hqJKZ119ITg.mp3?guid=ffffffffe5264219000001907177e797&vkey=456C7BB0368262EC76007E09195866EA4AB39A13D026F1EFAC0DDBB236F0429359F843624A14FB1F3AA539B2B7C6DF6636CFA2FB6C672821&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:52 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:52 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:52 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:52 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:04:52 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:04:52 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:52 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:52 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:52 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:52 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:52 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:52 localhost volumio[3745]: info: ------------------------------ 40ms
Jul 05 02:04:53 localhost volumio[3745]: info:
Jul 05 02:04:53 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:53 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:53 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:53 localhost volumio[3745]: info: sendMpdCommand status took 2 milliseconds
Jul 05 02:04:53 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:53 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:53 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:53 localhost volumio[3745]: 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 05 02:04:53 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::syncState stateService stop
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::play index undefined
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:53 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:53 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:53 localhost volumio[3745]: info: ------------------------------ 42ms
Jul 05 02:04:53 localhost volumio[3745]: info: Clearing queue after UPNP request
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::ClearQueue
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::stop
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:04:53 localhost volumio[3745]: UNSET VOLATILE
Jul 05 02:04:53 localhost volumio[3745]: info: CorePlayQueue::clearPlayQueue
Jul 05 02:04:53 localhost volumio[3745]: info: CorePlayQueue::saveQueue
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::volumioPushQueue
Jul 05 02:04:53 localhost volumio[3745]: info:
Jul 05 02:04:53 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:53 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:53 localhost volumio[3745]: error: updateQueue error: null
Jul 05 02:04:53 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:53 localhost volumio[3745]: info: Starting UPNP Playback
Jul 05 02:04:53 localhost volumio[3745]: info: Preparing playback through UPNP
Jul 05 02:04:53 localhost volumio[3745]: info: CoreCommandRouter::volumioGetState
Jul 05 02:04:53 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:04:53 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 05 02:04:53 localhost volumio[3745]: info:
Jul 05 02:04:53 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:53 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:53 localhost volumio[3745]: info:
Jul 05 02:04:53 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:53 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:53 localhost volumio[3745]: info: ------------------------------ 10ms
Jul 05 02:04:53 localhost volumio[3745]: info: ------------------------------ 5ms
Jul 05 02:04:53 localhost volumio[3745]: info:
Jul 05 02:04:53 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:53 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:54 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:54 localhost volumio[3745]: info:
Jul 05 02:04:54 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:54 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:54 localhost volumio[3745]: info: ------------------------------ 7ms
Jul 05 02:04:54 localhost volumio[3745]: info:
Jul 05 02:04:54 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:54 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:54 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:54 localhost volumio[3745]: info:
Jul 05 02:04:54 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:54 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:54 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:04:54 localhost volumio[3745]: info:
Jul 05 02:04:54 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:54 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:54 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:54 localhost volumio[3745]: info: sendMpdCommand status took 9 milliseconds
Jul 05 02:04:54 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:54 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:54 localhost volumio[3745]: info:
Jul 05 02:04:54 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:04:54 localhost volumio[3745]: info:
Jul 05 02:04:54 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:04:54 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:04:54 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:04:54 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:04:54 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 05 02:04:54 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:54 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:54 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:54 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":79,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包","artist":"DJ金旭","album":"紫米面包","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000jdtPN4IOMJg.mp3?guid=ffffffffe5264219000001907177e797&vkey=F87A3FE832E9D53642EE7420EB0C5782513AD8E7BD05A9FCBA1030D9C85996896436C6BCD3569D628154AA68B526AD4EA9FB1F10559A4681&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:54 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus stop
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:54 localhost volumio[3745]: info: ------------------------------ 40ms
Jul 05 02:04:54 localhost volumio[3745]: info: sendMpdCommand status took 34 milliseconds
Jul 05 02:04:54 localhost volumio[3745]: info: ------------------------------ 35ms
Jul 05 02:04:54 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:04:54 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:04:54 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jul 05 02:04:54 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:04:54 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:04:54 localhost volumio[3745]: In UPNP mode
Jul 05 02:04:54 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":79,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"紫米面包","artist":"DJ金旭","album":"紫米面包","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000jdtPN4IOMJg.mp3?guid=ffffffffe5264219000001907177e797&vkey=F87A3FE832E9D53642EE7420EB0C5782513AD8E7BD05A9FCBA1030D9C85996896436C6BCD3569D628154AA68B526AD4EA9FB1F10559A4681&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:04:54 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:04:54 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:04:54 localhost volumio[3745]: info: ------------------------------ 107ms
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:04:54 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:04:54 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:04:54 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:04:54 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:05:00 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:00 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:00 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:10 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:10 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:10 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:12 localhost volumio[3745]: info:
Jul 05 02:05:12 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:05:12 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:05:12 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:05:12 localhost volumio[3745]: info: sendMpdCommand status took 3 milliseconds
Jul 05 02:05:12 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:05:12 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:05:12 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 05 02:05:12 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:05:12 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:05:12 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:05:12 localhost volumio[3745]: 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":"DJ金旭","album":"紫米面包","uri":"http://116.31.98.36/amobile.music.tc.qq.com/M500000jdtPN4IOMJg.mp3?guid=ffffffffe5264219000001907177e797&vkey=F87A3FE832E9D53642EE7420EB0C5782513AD8E7BD05A9FCBA1030D9C85996896436C6BCD3569D628154AA68B526AD4EA9FB1F10559A4681&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:05:12 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::syncState stateService stop
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::play index undefined
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:05:12 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:05:12 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:05:12 localhost volumio[3745]: info: ------------------------------ 43ms
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:05:12 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:05:12 localhost volumio[3745]: info: Clearing queue after UPNP request
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::ClearQueue
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::stop
Jul 05 02:05:12 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 05 02:05:12 localhost volumio[3745]: UNSET VOLATILE
Jul 05 02:05:12 localhost volumio[3745]: info: CorePlayQueue::clearPlayQueue
Jul 05 02:05:12 localhost volumio[3745]: info: CorePlayQueue::saveQueue
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:05:12 localhost volumio[3745]: info: CoreCommandRouter::volumioPushQueue
Jul 05 02:05:12 localhost volumio[3745]: info:
Jul 05 02:05:12 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:05:13 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:05:13 localhost volumio[3745]: error: updateQueue error: null
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:05:13 localhost volumio[3745]: info: Starting UPNP Playback
Jul 05 02:05:13 localhost volumio[3745]: info: Preparing playback through UPNP
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::volumioGetState
Jul 05 02:05:13 localhost volumio[3745]: info: CorePlayQueue::getTrack 0
Jul 05 02:05:13 localhost volumio[3745]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:05:13 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:05:13 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:05:13 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:05:13 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:05:13 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 2ms
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:05:13 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 3ms
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:05:13 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:05:13 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:05:13 localhost volumio[3745]: info: sendMpdCommand status took 6 milliseconds
Jul 05 02:05:13 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:05:13 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:05:13 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:05:13 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:05:13 localhost volumio[3745]: info:
Jul 05 02:05:13 localhost volumio[3745]: ---------------------------- MPD announces system playlist update
Jul 05 02:05:13 localhost volumio[3745]: info: Ignoring MPD Status Update
Jul 05 02:05:13 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jul 05 02:05:13 localhost volumio[3745]: info: sendMpdCommand status took 7 milliseconds
Jul 05 02:05:13 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:05:13 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:05:13 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:05:13 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:05:13 localhost volumio[3745]: In UPNP mode
Jul 05 02:05:13 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":87,"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/M5000023UDqB0w4pcW.mp3?guid=ffffffffe5264219000001907177e797&vkey=33090CD83A3AEC92D120B65353C02715D11BA92A2AA422DFDCE1C4D6029E2B28B7EBDE1E27ABA8CF4AA66CB88DDAD96BCA494752160B3E06&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:05:13 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:05:13 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:05:13 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus stop
Jul 05 02:05:13 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 57ms
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 42ms
Jul 05 02:05:13 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 39 milliseconds
Jul 05 02:05:13 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:05:13 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:05:13 localhost volumio[3745]: In UPNP mode
Jul 05 02:05:13 localhost volumio[3745]: verbose: STATE SERVICE {"status":"play","position":0,"seek":313,"duration":87,"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/M5000023UDqB0w4pcW.mp3?guid=ffffffffe5264219000001907177e797&vkey=33090CD83A3AEC92D120B65353C02715D11BA92A2AA422DFDCE1C4D6029E2B28B7EBDE1E27ABA8CF4AA66CB88DDAD96BCA494752160B3E06&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:05:13 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:05:13 localhost volumio[3745]: info: CoreStateMachine::syncState stateService play
Jul 05 02:05:13 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:05:13 localhost volumio[3745]: info: Received an update from plugin. extracting info from payload
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 05 02:05:13 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:05:13 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:05:13 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:05:13 localhost volumio[3745]: info: ------------------------------ 127ms
Jul 05 02:05:14 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:05:14 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:05:14 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:05:14 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:05:14 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:05:14 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:05:20 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:20 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:30 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:30 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:30 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:40 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:40 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:40 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:44 localhost volumio[3745]: info:
Jul 05 02:05:44 localhost volumio[3745]: ---------------------------- MPD announces state update: player
Jul 05 02:05:44 localhost volumio[3745]: info: ControllerMpd::getState
Jul 05 02:05:44 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 02:05:44 localhost volumio[3745]: info: sendMpdCommand status took 3 milliseconds
Jul 05 02:05:44 localhost volumio[3745]: verbose: ControllerMpd::parseState
Jul 05 02:05:45 localhost volumio[3745]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 02:05:45 localhost volumio[3745]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 05 02:05:45 localhost volumio[3745]: verbose: ControllerMpd::parseTrackInfo
Jul 05 02:05:45 localhost volumio[3745]: info: ControllerMpd::pushState
Jul 05 02:05:45 localhost volumio[3745]: info: CoreCommandRouter::servicePushState
Jul 05 02:05:45 localhost volumio[3745]: In UPNP mode
Jul 05 02:05:45 localhost volumio[3745]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":31486,"duration":87,"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/M5000023UDqB0w4pcW.mp3?guid=ffffffffe5264219000001907177e797&vkey=33090CD83A3AEC92D120B65353C02715D11BA92A2AA422DFDCE1C4D6029E2B28B7EBDE1E27ABA8CF4AA66CB88DDAD96BCA494752160B3E06&uin=&redirect=1&fromtag=111042","trackType":""}
Jul 05 02:05:45 localhost volumio[3745]: verbose: CURRENT POSITION 0
Jul 05 02:05:45 localhost volumio[3745]: info: CoreStateMachine::syncState stateService pause
Jul 05 02:05:45 localhost volumio[3745]: info: CoreStateMachine::syncState currentStatus play
Jul 05 02:05:45 localhost volumio[3745]: info: CoreStateMachine::pushState
Jul 05 02:05:45 localhost volumio[3745]: info: CoreCommandRouter::volumioPushState
Jul 05 02:05:45 localhost volumio[3745]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 02:05:45 localhost volumio[3745]: info: CoreStateMachine::stPlaybackTimer
Jul 05 02:05:45 localhost volumio[3745]: info: ------------------------------ 27ms
Jul 05 02:05:45 localhost volumio[3745]: info: CoreCommandRouter::volumioGetQueue
Jul 05 02:05:45 localhost volumio[3745]: info: CoreStateMachine::getQueue
Jul 05 02:05:45 localhost volumio[3745]: info: CorePlayQueue::getQueue
Jul 05 02:05:50 localhost volumio[3745]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 05 02:05:50 localhost volumio[3745]: { Error: connect ETIMEDOUT 31.13.80.169:443
Jul 05 02:05:50 localhost volumio[3745]: at Object._errnoException (util.js:1022:11)
Jul 05 02:05:50 localhost volumio[3745]: at _exceptionWithHostPort (util.js:1044:20)
Jul 05 02:05:50 localhost volumio[3745]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Jul 05 02:05:50 localhost volumio[3745]: code: 'ETIMEDOUT',
Jul 05 02:05:50 localhost volumio[3745]: errno: 'ETIMEDOUT',
Jul 05 02:05:50 localhost volumio[3745]: syscall: 'connect',
Jul 05 02:05:50 localhost volumio[3745]: address: '31.13.80.169',
Jul 05 02:05:50 localhost volumio[3745]: port: 443 }
Jul 05 02:05:50 localhost volumio[3745]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 05 02:05:50 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:50 localhost avahi-daemon[609]: Received response from host 192.168.3.97 with invalid source port 55638 on interface 'eth0.0'
Jul 05 02:05:51 localhost sudo[7220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-05 02:04
Jul 05 02:05:51 localhost sudo[7220]: 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"