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