-- Logs begin at Sat 2024-10-19 13:44:14 UTC, end at Sun 2024-10-20 08:01:49 UTC. -- Oct 20 08:00:25 localhost volumio[18980]: info: Clearing queue after UPNP request Oct 20 08:00:25 localhost volumio[18980]: info: CoreStateMachine::ClearQueue Oct 20 08:00:25 localhost volumio[18980]: info: CoreStateMachine::stop Oct 20 08:00:25 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 08:00:25 localhost volumio[18980]: verbose: UNSET VOLATILE Oct 20 08:00:25 localhost volumio[18980]: info: CorePlayQueue::clearPlayQueue Oct 20 08:00:25 localhost volumio[18980]: info: CorePlayQueue::saveQueue Oct 20 08:00:25 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:25 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:25 localhost volumio[18980]: info: CoreCommandRouter::volumioPushQueue Oct 20 08:00:25 localhost volumio[18980]: info: Oct 20 08:00:25 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:25 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:25 localhost volumio[18980]: error: updateQueue error: null Oct 20 08:00:25 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:25 localhost volumio[18980]: info: Starting UPNP Playback Oct 20 08:00:25 localhost volumio[18980]: info: Preparing playback through UPNP Oct 20 08:00:25 localhost volumio[18980]: info: CoreCommandRouter::volumioGetState Oct 20 08:00:25 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:25 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 08:00:25 localhost volumio[18980]: info: Oct 20 08:00:25 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:25 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:25 localhost volumio[18980]: info: Oct 20 08:00:25 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:25 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:25 localhost volumio[18980]: info: ------------------------------ 2ms Oct 20 08:00:25 localhost volumio[18980]: info: ------------------------------ 2ms Oct 20 08:00:25 localhost volumio[18980]: info: Oct 20 08:00:25 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:25 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:25 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:25 localhost volumio[18980]: info: Oct 20 08:00:25 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:25 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:25 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:25 localhost volumio[18980]: info: Oct 20 08:00:25 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:25 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:25 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:25 localhost volumio[18980]: info: Oct 20 08:00:25 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:25 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:25 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:26 localhost volumio[18980]: info: Oct 20 08:00:26 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:26 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:26 localhost volumio[18980]: info: Oct 20 08:00:26 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:26 localhost volumio[18980]: info: sendMpdCommand status took 6 milliseconds Oct 20 08:00:26 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:26 localhost volumio[18980]: info: Oct 20 08:00:26 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:26 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:26 localhost volumio[18980]: info: sendMpdCommand status took 5 milliseconds Oct 20 08:00:26 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:26 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:26 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:26 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"493 Kbps","isStreaming":false,"title":"威廉古堡","artist":"周杰伦","album":"范特西","uri":"http://fsandroid.tx.kugou.com/202410201600/7fca270db9f3e32b6364de05af5738c2/v3/733691dc356e6586324a52cea3de7104/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32027752_quflac_s1854029841.flac","trackType":"flac"} Oct 20 08:00:26 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus stop Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:26 localhost volumio[18980]: info: ------------------------------ 25ms Oct 20 08:00:26 localhost volumio[18980]: info: ------------------------------ 15ms Oct 20 08:00:26 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:26 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:26 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:26 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"493 Kbps","isStreaming":false,"title":"威廉古堡","artist":"周杰伦","album":"范特西","uri":"http://fsandroid.tx.kugou.com/202410201600/7fca270db9f3e32b6364de05af5738c2/v3/733691dc356e6586324a52cea3de7104/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32027752_quflac_s1854029841.flac","trackType":"flac"} Oct 20 08:00:26 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:26 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:26 localhost volumio[18980]: info: ------------------------------ 37ms Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:26 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:26 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:26 localhost volumio[18980]: info: Oct 20 08:00:26 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:26 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:26 localhost volumio[18980]: info: sendMpdCommand status took 10 milliseconds Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:26 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 20 08:00:26 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:26 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:26 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:26 localhost volumio[18980]: 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://fsandroid.tx.kugou.com/202410201600/7fca270db9f3e32b6364de05af5738c2/v3/733691dc356e6586324a52cea3de7104/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32027752_quflac_s1854029841.flac","trackType":"flac"} Oct 20 08:00:26 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::syncState stateService stop Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::stPlaybackTimer Oct 20 08:00:26 localhost volumio[18980]: info: ------------------------------ 33ms Oct 20 08:00:26 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:26 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:26 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:26 localhost volumio[18980]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E4%BC%A6/Jay/4a58c3f3-e661-4059-baf6-084976f7ad85.jpg' Oct 20 08:00:26 localhost volumio[18980]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E4%BC%A6/%E8%8C%83%E7%89%B9%E8%A5%BF/d784ddde-f089-497d-a62b-a85646b6c7c8.jpg' Oct 20 08:00:26 localhost volumio[18980]: info: Clearing queue after UPNP request Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::ClearQueue Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::stop Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 08:00:27 localhost volumio[18980]: verbose: UNSET VOLATILE Oct 20 08:00:27 localhost volumio[18980]: info: CorePlayQueue::clearPlayQueue Oct 20 08:00:27 localhost volumio[18980]: info: CorePlayQueue::saveQueue Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::volumioPushQueue Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:27 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:27 localhost volumio[18980]: error: updateQueue error: null Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:27 localhost volumio[18980]: info: Starting UPNP Playback Oct 20 08:00:27 localhost volumio[18980]: info: Preparing playback through UPNP Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::volumioGetState Oct 20 08:00:27 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:27 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 3ms Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:27 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:27 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:27 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 0ms Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:27 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:27 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:27 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:27 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:27 localhost volumio[18980]: info: sendMpdCommand status took 23 milliseconds Oct 20 08:00:27 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:27 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:27 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:27 localhost volumio[18980]: info: Oct 20 08:00:27 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:27 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:27 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:27 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 6ms Oct 20 08:00:27 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:27 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:27 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:27 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":342,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32100648_quhigh_s2708923903.flac","artist":null,"album":"叶惠美","uri":"http://fsandroid.tx.kugou.com/202410201600/d6c11e9b21043cc3c0f3fc4365abcf52/v3/aa1de0fb7da37d32b3a8fca5cfb737db/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32100648_quhigh_s2708923903.flac","trackType":"flac"} Oct 20 08:00:27 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus stop Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 51ms Oct 20 08:00:27 localhost volumio[18980]: info: sendMpdCommand status took 27 milliseconds Oct 20 08:00:27 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:27 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:27 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 20 08:00:27 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:27 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:27 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:27 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":342,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1206 Kbps","isStreaming":false,"title":"ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32100648_quhigh_s2708923903.flac","artist":null,"album":"叶惠美","uri":"http://fsandroid.tx.kugou.com/202410201600/d6c11e9b21043cc3c0f3fc4365abcf52/v3/aa1de0fb7da37d32b3a8fca5cfb737db/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32100648_quhigh_s2708923903.flac","trackType":"flac"} Oct 20 08:00:27 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:27 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:27 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:27 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:27 localhost volumio[18980]: info: ------------------------------ 51ms Oct 20 08:00:28 localhost volumio[18980]: info: Oct 20 08:00:28 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:28 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:28 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:28 localhost volumio[18980]: info: sendMpdCommand status took 0 milliseconds Oct 20 08:00:28 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:28 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:28 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 20 08:00:28 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:28 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:28 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:28 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:28 localhost volumio[18980]: 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":"ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32100648_quhigh_s2708923903.flac","artist":null,"album":"叶惠美","uri":"http://fsandroid.tx.kugou.com/202410201600/d6c11e9b21043cc3c0f3fc4365abcf52/v3/aa1de0fb7da37d32b3a8fca5cfb737db/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32100648_quhigh_s2708923903.flac","trackType":"flac"} Oct 20 08:00:28 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:28 localhost volumio[18980]: info: CoreStateMachine::syncState stateService stop Oct 20 08:00:28 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:28 localhost volumio[18980]: info: CoreStateMachine::stPlaybackTimer Oct 20 08:00:28 localhost volumio[18980]: info: ------------------------------ 8ms Oct 20 08:00:28 localhost volumio[18980]: info: Clearing queue after UPNP request Oct 20 08:00:28 localhost volumio[18980]: info: CoreStateMachine::ClearQueue Oct 20 08:00:28 localhost volumio[18980]: info: CoreStateMachine::stop Oct 20 08:00:28 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 08:00:28 localhost volumio[18980]: verbose: UNSET VOLATILE Oct 20 08:00:28 localhost volumio[18980]: info: CorePlayQueue::clearPlayQueue Oct 20 08:00:28 localhost volumio[18980]: info: CorePlayQueue::saveQueue Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::volumioPushQueue Oct 20 08:00:28 localhost volumio[18980]: info: Oct 20 08:00:28 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:28 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:28 localhost volumio[18980]: info: Starting UPNP Playback Oct 20 08:00:28 localhost volumio[18980]: info: Preparing playback through UPNP Oct 20 08:00:28 localhost volumio[18980]: info: CoreCommandRouter::volumioGetState Oct 20 08:00:28 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:28 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 08:00:28 localhost volumio[18980]: error: updateQueue error: null Oct 20 08:00:28 localhost volumio[18980]: info: ------------------------------ 2ms Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:29 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:29 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 2ms Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:29 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:29 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:29 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:29 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:29 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:29 localhost volumio[18980]: info: sendMpdCommand status took 5 milliseconds Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:29 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:29 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:29 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:29 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:29 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:29 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"那片海","artist":"李克勤","album":"中国梦之声·我们的歌 第9期","uri":"http://fsandroid.tx.kugou.com/202410201600/a9beb9f15e7c4a44d3967baa914e8043/v3/9f7376999b1cae0b1a13d5c9ddfce56e/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx245468787_quhigh_s2963647940.flac","trackType":"flac"} Oct 20 08:00:29 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus stop Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 27ms Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 22ms Oct 20 08:00:29 localhost volumio[18980]: info: sendMpdCommand status took 22 milliseconds Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:29 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:29 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:29 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:29 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":262,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1201 Kbps","isStreaming":false,"title":"那片海","artist":"李克勤","album":"中国梦之声·我们的歌 第9期","uri":"http://fsandroid.tx.kugou.com/202410201600/a9beb9f15e7c4a44d3967baa914e8043/v3/9f7376999b1cae0b1a13d5c9ddfce56e/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx245468787_quhigh_s2963647940.flac","trackType":"flac"} Oct 20 08:00:29 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:29 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 63ms Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:29 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:29 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:29 localhost volumio[18980]: info: Oct 20 08:00:29 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:29 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:29 localhost volumio[18980]: info: sendMpdCommand status took 3 milliseconds Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:29 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 20 08:00:29 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:29 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:29 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:29 localhost volumio[18980]: 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":"中国梦之声·我们的歌 第9期","uri":"http://fsandroid.tx.kugou.com/202410201600/a9beb9f15e7c4a44d3967baa914e8043/v3/9f7376999b1cae0b1a13d5c9ddfce56e/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx245468787_quhigh_s2963647940.flac","trackType":"flac"} Oct 20 08:00:29 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::syncState stateService stop Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::stPlaybackTimer Oct 20 08:00:29 localhost volumio[18980]: info: ------------------------------ 22ms Oct 20 08:00:29 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:29 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:29 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:29 localhost volumio[18980]: info: Clearing queue after UPNP request Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::ClearQueue Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::stop Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 08:00:30 localhost volumio[18980]: verbose: UNSET VOLATILE Oct 20 08:00:30 localhost volumio[18980]: info: CorePlayQueue::clearPlayQueue Oct 20 08:00:30 localhost volumio[18980]: info: CorePlayQueue::saveQueue Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioPushQueue Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:30 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:30 localhost volumio[18980]: error: updateQueue error: null Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:30 localhost volumio[18980]: info: Starting UPNP Playback Oct 20 08:00:30 localhost volumio[18980]: info: Preparing playback through UPNP Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioGetState Oct 20 08:00:30 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:30 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:30 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 2ms Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:30 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:30 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:30 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:30 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:30 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:30 localhost volumio[18980]: info: sendMpdCommand status took 25 milliseconds Oct 20 08:00:30 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:30 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:30 localhost volumio[18980]: info: Oct 20 08:00:30 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:30 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:30 localhost volumio[18980]: info: sendMpdCommand status took 7 milliseconds Oct 20 08:00:30 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:30 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:30 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:30 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"她说","artist":"林俊杰","album":"她说 概念自选辑","uri":"http://fsandroid.tx.kugou.com/202410201600/70a836b16bc8cf7aa1784edc5e736021/v3/26faa194e9301787f3441ab1758a087d/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32246703_quflac_s3606122670.flac","trackType":"flac"} Oct 20 08:00:30 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus stop Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 51ms Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 20ms Oct 20 08:00:30 localhost volumio[18980]: info: sendMpdCommand status took 18 milliseconds Oct 20 08:00:30 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 17 milliseconds Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:30 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:30 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:30 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"503 Kbps","isStreaming":false,"title":"她说","artist":"林俊杰","album":"她说 概念自选辑","uri":"http://fsandroid.tx.kugou.com/202410201600/70a836b16bc8cf7aa1784edc5e736021/v3/26faa194e9301787f3441ab1758a087d/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32246703_quflac_s3606122670.flac","trackType":"flac"} Oct 20 08:00:30 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:30 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:30 localhost volumio[18980]: info: ------------------------------ 42ms Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:30 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:30 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:30 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 20 08:00:30 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:30 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:30 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:30 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"503 Kbps","isStreaming":false,"title":"她说","artist":"林俊杰","album":"她说 概念自选辑","uri":"http://fsandroid.tx.kugou.com/202410201600/70a836b16bc8cf7aa1784edc5e736021/v3/26faa194e9301787f3441ab1758a087d/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32246703_quflac_s3606122670.flac","trackType":"flac"} Oct 20 08:00:30 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:30 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 20 08:00:30 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:30 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:31 localhost volumio[18980]: info: ------------------------------ 58ms Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:31 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:31 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:31 localhost volumio[18980]: info: Oct 20 08:00:31 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:31 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:31 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:31 localhost volumio[18980]: info: sendMpdCommand status took 2 milliseconds Oct 20 08:00:31 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:31 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:31 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 20 08:00:31 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:31 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:31 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:31 localhost volumio[18980]: 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://fsandroid.tx.kugou.com/202410201600/70a836b16bc8cf7aa1784edc5e736021/v3/26faa194e9301787f3441ab1758a087d/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32246703_quflac_s3606122670.flac","trackType":"flac"} Oct 20 08:00:31 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::syncState stateService stop Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::stPlaybackTimer Oct 20 08:00:31 localhost volumio[18980]: info: ------------------------------ 16ms Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:31 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:31 localhost volumio[18980]: info: Clearing queue after UPNP request Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::ClearQueue Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::stop Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 08:00:31 localhost volumio[18980]: verbose: UNSET VOLATILE Oct 20 08:00:31 localhost volumio[18980]: info: CorePlayQueue::clearPlayQueue Oct 20 08:00:31 localhost volumio[18980]: info: CorePlayQueue::saveQueue Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioPushQueue Oct 20 08:00:31 localhost volumio[18980]: info: Oct 20 08:00:31 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:31 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:31 localhost volumio[18980]: info: Starting UPNP Playback Oct 20 08:00:31 localhost volumio[18980]: info: Preparing playback through UPNP Oct 20 08:00:31 localhost volumio[18980]: info: CoreCommandRouter::volumioGetState Oct 20 08:00:31 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:31 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 08:00:31 localhost volumio[18980]: error: updateQueue error: null Oct 20 08:00:31 localhost volumio[18980]: info: ------------------------------ 2ms Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:32 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 6ms Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:32 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:32 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:32 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 0ms Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:32 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:32 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:32 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:32 localhost volumio[18980]: info: sendMpdCommand status took 5 milliseconds Oct 20 08:00:32 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:32 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:32 localhost volumio[18980]: info: sendMpdCommand status took 4 milliseconds Oct 20 08:00:32 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:32 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:32 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:32 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"普通朋友","artist":"陶喆","album":"I'm OK","uri":"http://fsandroid.tx.kugou.com/202410201600/de697d35ccb16bec2e8211f28b501f48/v3/233763630be7b21d3e2d38c87b57d75a/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32053350_quflac_s737806084.flac","trackType":"flac"} Oct 20 08:00:32 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus stop Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 23ms Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 18ms Oct 20 08:00:32 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 17 milliseconds Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:32 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:32 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:32 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"496 Kbps","isStreaming":false,"title":"普通朋友","artist":"陶喆","album":"I'm OK","uri":"http://fsandroid.tx.kugou.com/202410201600/de697d35ccb16bec2e8211f28b501f48/v3/233763630be7b21d3e2d38c87b57d75a/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32053350_quflac_s737806084.flac","trackType":"flac"} Oct 20 08:00:32 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:32 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 39ms Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:32 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:32 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:32 localhost volumio[18980]: info: Oct 20 08:00:32 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:32 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:32 localhost volumio[18980]: info: sendMpdCommand status took 2 milliseconds Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:32 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 20 08:00:32 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:32 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:32 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:32 localhost volumio[18980]: 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":"I'm OK","uri":"http://fsandroid.tx.kugou.com/202410201600/de697d35ccb16bec2e8211f28b501f48/v3/233763630be7b21d3e2d38c87b57d75a/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx32053350_quflac_s737806084.flac","trackType":"flac"} Oct 20 08:00:32 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::syncState stateService stop Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::stPlaybackTimer Oct 20 08:00:32 localhost volumio[18980]: info: ------------------------------ 18ms Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:32 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:32 localhost volumio[18980]: info: Clearing queue after UPNP request Oct 20 08:00:32 localhost volumio[18980]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%B6%E5%96%86/I%27m%20OK/fa279a78-21dd-4919-bda8-b7f9927a727b.png' Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::ClearQueue Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::stop Oct 20 08:00:32 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 08:00:32 localhost volumio[18980]: verbose: UNSET VOLATILE Oct 20 08:00:32 localhost volumio[18980]: info: CorePlayQueue::clearPlayQueue Oct 20 08:00:32 localhost volumio[18980]: info: CorePlayQueue::saveQueue Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:32 localhost volumio[18980]: info: CoreCommandRouter::volumioPushQueue Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:33 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:33 localhost volumio[18980]: info: Starting UPNP Playback Oct 20 08:00:33 localhost volumio[18980]: info: Preparing playback through UPNP Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioGetState Oct 20 08:00:33 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 08:00:33 localhost volumio[18980]: error: updateQueue error: null Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 5ms Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:33 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 3ms Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:33 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:33 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:33 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 2ms Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:33 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:33 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:33 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:33 localhost volumio[18980]: info: sendMpdCommand status took 4 milliseconds Oct 20 08:00:33 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:33 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:33 localhost volumio[18980]: info: sendMpdCommand status took 3 milliseconds Oct 20 08:00:33 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 3ms Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:33 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:33 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:33 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"533 Kbps","isStreaming":false,"title":"I Turn to You","artist":"Christina Aguilera","album":"公告榜前100单曲（2000）","uri":"http://fsandroid.tx.kugou.com/202410201600/61c9514400a06b528a6b59e76374e88f/v3/de4ca907fed7530b358c093f2604213c/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx64388794_quhigh_s3480457137.flac","trackType":"flac"} Oct 20 08:00:33 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus stop Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 25ms Oct 20 08:00:33 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 17 milliseconds Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:33 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:33 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:33 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"543 Kbps","isStreaming":false,"title":"I Turn to You","artist":"Christina Aguilera","album":"公告榜前100单曲（2000）","uri":"http://fsandroid.tx.kugou.com/202410201600/61c9514400a06b528a6b59e76374e88f/v3/de4ca907fed7530b358c093f2604213c/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx64388794_quhigh_s3480457137.flac","trackType":"flac"} Oct 20 08:00:33 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:33 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 45ms Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:33 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:33 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:33 localhost volumio[18980]: info: Oct 20 08:00:33 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:33 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:33 localhost volumio[18980]: info: sendMpdCommand status took 2 milliseconds Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:33 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 20 08:00:33 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:33 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:33 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:33 localhost volumio[18980]: 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":"I Turn to You","artist":"Christina Aguilera","album":"公告榜前100单曲（2000）","uri":"http://fsandroid.tx.kugou.com/202410201600/61c9514400a06b528a6b59e76374e88f/v3/de4ca907fed7530b358c093f2604213c/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx64388794_quhigh_s3480457137.flac","trackType":"flac"} Oct 20 08:00:33 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::syncState stateService stop Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::stPlaybackTimer Oct 20 08:00:33 localhost volumio[18980]: info: ------------------------------ 19ms Oct 20 08:00:33 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:33 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:33 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:33 localhost volumio[18980]: info: Clearing queue after UPNP request Oct 20 08:00:34 localhost volumio[18980]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%B6%E5%96%86/I%27m%20OK/fa279a78-21dd-4919-bda8-b7f9927a727b.png' Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::ClearQueue Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::stop Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 08:00:34 localhost volumio[18980]: verbose: UNSET VOLATILE Oct 20 08:00:34 localhost volumio[18980]: info: CorePlayQueue::clearPlayQueue Oct 20 08:00:34 localhost volumio[18980]: info: CorePlayQueue::saveQueue Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::volumioPushQueue Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:34 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:34 localhost volumio[18980]: error: updateQueue error: null Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:34 localhost volumio[18980]: info: Starting UPNP Playback Oct 20 08:00:34 localhost volumio[18980]: info: Preparing playback through UPNP Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::volumioGetState Oct 20 08:00:34 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:34 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:34 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:34 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 0ms Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:34 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:34 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:34 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:34 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:34 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:34 localhost volumio[18980]: info: sendMpdCommand status took 3 milliseconds Oct 20 08:00:34 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:34 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:34 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:34 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:34 localhost volumio[18980]: info: Oct 20 08:00:34 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:34 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:34 localhost volumio[18980]: info: sendMpdCommand status took 11 milliseconds Oct 20 08:00:34 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 20 08:00:34 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:34 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:34 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:34 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:34 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:34 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":452,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"861 Kbps","isStreaming":false,"title":"As Long As You Love Me 只要你爱我_BackStreet Boys","artist":"Best Of The Boy Bands","album":"Best Of The Boy Bands 冠军天团风云录","uri":"http://fsandroid.tx.kugou.com/202410201600/6cd923ed40af3dbd10f1c3625378a219/v3/ec5e9525039ea83e1afecb8ae917df06/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx96024153_quhigh_s2396564655.flac","trackType":"flac"} Oct 20 08:00:34 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus stop Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 41ms Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 28ms Oct 20 08:00:34 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 20 08:00:34 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:34 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:34 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:34 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"861 Kbps","isStreaming":false,"title":"As Long As You Love Me 只要你爱我_BackStreet Boys","artist":"Best Of The Boy Bands","album":"Best Of The Boy Bands 冠军天团风云录","uri":"http://fsandroid.tx.kugou.com/202410201600/6cd923ed40af3dbd10f1c3625378a219/v3/ec5e9525039ea83e1afecb8ae917df06/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx96024153_quhigh_s2396564655.flac","trackType":"flac"} Oct 20 08:00:34 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:34 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:34 localhost volumio[18980]: info: ------------------------------ 63ms Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:34 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:34 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:34 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:34 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:41 localhost volumio[18980]: info: Oct 20 08:00:41 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:41 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:41 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:41 localhost volumio[18980]: info: sendMpdCommand status took 3 milliseconds Oct 20 08:00:41 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:41 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:41 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 20 08:00:41 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:41 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:41 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:41 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:41 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:41 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:41 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:41 localhost volumio[18980]: 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":"As Long As You Love Me 只要你爱我_BackStreet Boys","artist":"Best Of The Boy Bands","album":"Best Of The Boy Bands 冠军天团风云录","uri":"http://fsandroid.tx.kugou.com/202410201600/6cd923ed40af3dbd10f1c3625378a219/v3/ec5e9525039ea83e1afecb8ae917df06/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx96024153_quhigh_s2396564655.flac","trackType":"flac"} Oct 20 08:00:41 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:41 localhost volumio[18980]: info: CoreStateMachine::syncState stateService stop Oct 20 08:00:41 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:41 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:41 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:41 localhost volumio[18980]: info: CoreStateMachine::stPlaybackTimer Oct 20 08:00:41 localhost volumio[18980]: info: ------------------------------ 12ms Oct 20 08:00:41 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:41 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:41 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:42 localhost volumio[18980]: info: Clearing queue after UPNP request Oct 20 08:00:42 localhost volumio[18980]: info: CoreStateMachine::ClearQueue Oct 20 08:00:42 localhost volumio[18980]: info: CoreStateMachine::stop Oct 20 08:00:42 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 08:00:42 localhost volumio[18980]: verbose: UNSET VOLATILE Oct 20 08:00:42 localhost volumio[18980]: info: CorePlayQueue::clearPlayQueue Oct 20 08:00:42 localhost volumio[18980]: info: CorePlayQueue::saveQueue Oct 20 08:00:42 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:42 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:42 localhost volumio[18980]: info: CoreCommandRouter::volumioPushQueue Oct 20 08:00:42 localhost volumio[18980]: info: Oct 20 08:00:42 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:42 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:42 localhost volumio[18980]: error: updateQueue error: null Oct 20 08:00:42 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:42 localhost volumio[18980]: info: Starting UPNP Playback Oct 20 08:00:42 localhost volumio[18980]: info: Preparing playback through UPNP Oct 20 08:00:42 localhost volumio[18980]: info: CoreCommandRouter::volumioGetState Oct 20 08:00:42 localhost volumio[18980]: info: CorePlayQueue::getTrack 0 Oct 20 08:00:42 localhost volumio[18980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 08:00:42 localhost volumio[18980]: info: Oct 20 08:00:42 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:42 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:42 localhost volumio[18980]: info: ------------------------------ 6ms Oct 20 08:00:42 localhost volumio[18980]: info: Oct 20 08:00:42 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:42 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:42 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:42 localhost volumio[18980]: info: Oct 20 08:00:42 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:42 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:42 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:42 localhost volumio[18980]: info: Oct 20 08:00:42 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:42 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:42 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:42 localhost volumio[18980]: info: Oct 20 08:00:42 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:42 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:42 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:42 localhost volumio[18980]: info: Oct 20 08:00:42 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:42 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:42 localhost volumio[18980]: info: ------------------------------ 1ms Oct 20 08:00:43 localhost volumio[18980]: info: Oct 20 08:00:43 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:43 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:43 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:43 localhost volumio[18980]: info: Oct 20 08:00:43 localhost volumio[18980]: ---------------------------- MPD announces system playlist update Oct 20 08:00:43 localhost volumio[18980]: info: Ignoring MPD Status Update Oct 20 08:00:43 localhost volumio[18980]: info: Oct 20 08:00:43 localhost volumio[18980]: ---------------------------- MPD announces state update: player Oct 20 08:00:43 localhost volumio[18980]: info: ControllerMpd::getState Oct 20 08:00:43 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand status Oct 20 08:00:43 localhost volumio[18980]: info: sendMpdCommand status took 8 milliseconds Oct 20 08:00:43 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:43 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:43 localhost volumio[18980]: info: ------------------------------ 7ms Oct 20 08:00:43 localhost volumio[18980]: info: sendMpdCommand status took 7 milliseconds Oct 20 08:00:43 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 20 08:00:43 localhost volumio[18980]: verbose: ControllerMpd::parseState Oct 20 08:00:43 localhost volumio[18980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 08:00:43 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:43 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:43 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:43 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":229,"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://fsandroid.tx.kugou.com/202410201600/80c803e3e91148fdcb1e540c2fada9d0/v3/a375ce55d9cc9bdc7f52c677c64173b3/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx66326756_qu128_s1030245124.mp3","trackType":"mp3"} Oct 20 08:00:43 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus stop Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:43 localhost volumio[18980]: info: ------------------------------ 48ms Oct 20 08:00:43 localhost volumio[18980]: info: sendMpdCommand playlistinfo took 30 milliseconds Oct 20 08:00:43 localhost volumio[18980]: verbose: ControllerMpd::parseTrackInfo Oct 20 08:00:43 localhost volumio[18980]: info: ControllerMpd::pushState Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::servicePushState Oct 20 08:00:43 localhost volumio[18980]: verbose: In UPNP mode Oct 20 08:00:43 localhost volumio[18980]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":229,"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://fsandroid.tx.kugou.com/202410201600/80c803e3e91148fdcb1e540c2fada9d0/v3/a375ce55d9cc9bdc7f52c677c64173b3/yp/full/ap1005_us997997778_df0inpqt1dfyu23wzep12dr2lb_pi2_mx66326756_qu128_s1030245124.mp3","trackType":"mp3"} Oct 20 08:00:43 localhost volumio[18980]: verbose: CURRENT POSITION 0 Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::syncState stateService play Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::syncState currentStatus play Oct 20 08:00:43 localhost volumio[18980]: info: Received an update from plugin. extracting info from payload Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::pushState Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::volumioPushState Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 08:00:43 localhost volumio[18980]: info: ------------------------------ 79ms Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:43 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:00:43 localhost volumio[18980]: info: CoreCommandRouter::volumioGetQueue Oct 20 08:00:43 localhost volumio[18980]: info: CoreStateMachine::getQueue Oct 20 08:00:43 localhost volumio[18980]: info: CorePlayQueue::getQueue Oct 20 08:01:49 localhost volumio[18980]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 20 08:01:49 localhost volumio[18980]: { Error: connect ETIMEDOUT 31.13.95.18:443 Oct 20 08:01:49 localhost volumio[18980]: at Object._errnoException (util.js:1022:11) Oct 20 08:01:49 localhost volumio[18980]: at _exceptionWithHostPort (util.js:1044:20) Oct 20 08:01:49 localhost volumio[18980]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 20 08:01:49 localhost volumio[18980]: code: 'ETIMEDOUT', Oct 20 08:01:49 localhost volumio[18980]: errno: 'ETIMEDOUT', Oct 20 08:01:49 localhost volumio[18980]: syscall: 'connect', Oct 20 08:01:49 localhost volumio[18980]: address: '31.13.95.18', Oct 20 08:01:49 localhost volumio[18980]: port: 443 } Oct 20 08:01:49 localhost volumio[18980]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 20 08:01:49 localhost sudo[28394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-20 08:00 Oct 20 08:01:49 localhost sudo[28394]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"