-- 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"