-- Logs begin at Wed 2025-10-29 04:42:08 UTC, end at Thu 2025-10-30 06:01:53 UTC. -- Oct 30 06:00:00 volumio volumio[4024]: info: Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:00 volumio volumio[4024]: info: Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:00 volumio volumio[4024]: info: Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:00 volumio volumio[4024]: info: Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:00 volumio volumio[4024]: info: Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:00 volumio volumio[4024]: info: Oct 30 06:00:00 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:00 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:00 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:01 volumio volumio[4024]: info: Oct 30 06:00:01 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:01 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:01 volumio volumio[4024]: info: sendMpdCommand status took 6 milliseconds Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:01 volumio volumio[4024]: info: Oct 30 06:00:01 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:01 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:01 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:00:01 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:01 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:01 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:01 volumio volumio[4024]: In UPNP mode Oct 30 06:00:01 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:50425/bridge-92.flac","trackType":"flac"} Oct 30 06:00:01 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:01 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play Oct 30 06:00:01 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus stop Oct 30 06:00:01 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:01 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:02 volumio volumio[4024]: info: ------------------------------ 10ms Oct 30 06:00:02 volumio volumio[4024]: info: sendMpdCommand status took 5 milliseconds Oct 30 06:00:02 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:02 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:02 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 30 06:00:02 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:02 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:02 volumio volumio[4024]: In UPNP mode Oct 30 06:00:02 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":319,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1909 Kbps","isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:50425/bridge-92.flac","trackType":"flac"} Oct 30 06:00:02 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:02 volumio volumio[4024]: info: Received an update from plugin. extracting info from payload Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:02 volumio volumio[4024]: info: ------------------------------ 9ms Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:02 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:02 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:02 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:02 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:02 volumio volumio[4024]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/%E5%8F%A6%E4%B8%80%E7%A7%8D%E6%83%85%E6%84%9F/d0292c45-0ac5-460a-8120-630a110febf6.jpg' Oct 30 06:00:05 volumio volumio[4024]: info: Oct 30 06:00:05 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:05 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:05 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:05 volumio volumio[4024]: info: sendMpdCommand status took 0 milliseconds Oct 30 06:00:05 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:05 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:05 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:00:05 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:05 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:05 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:05 volumio volumio[4024]: In UPNP mode Oct 30 06:00:05 volumio volumio[4024]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2734,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1913 Kbps","isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:50425/bridge-92.flac","trackType":"flac"} Oct 30 06:00:05 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::syncState stateService pause Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:05 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:05 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer Oct 30 06:00:05 volumio volumio[4024]: info: ------------------------------ 3ms Oct 30 06:00:05 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:05 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:05 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:15 volumio volumio[4024]: info: Oct 30 06:00:15 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:15 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:15 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:15 volumio volumio[4024]: info: sendMpdCommand status took 1 milliseconds Oct 30 06:00:15 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:15 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:15 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 30 06:00:15 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:15 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::getTrack 0 Oct 30 06:00:15 volumio volumio[4024]: 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://192.168.1.17:50425/bridge-92.flac","trackType":"flac"} Oct 30 06:00:15 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::syncState stateService stop Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer Oct 30 06:00:15 volumio volumio[4024]: info: ------------------------------ 7ms Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:15 volumio volumio[4024]: info: Clearing queue after UPNP request Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::ClearQueue Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::stop Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 30 06:00:15 volumio volumio[4024]: UNSET VOLATILE Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::clearPlayQueue Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::saveQueue Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioPushQueue Oct 30 06:00:15 volumio volumio[4024]: info: Oct 30 06:00:15 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:15 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:15 volumio volumio[4024]: error: updateQueue error: null Oct 30 06:00:15 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:15 volumio volumio[4024]: info: Starting UPNP Playback Oct 30 06:00:15 volumio volumio[4024]: info: Preparing playback through UPNP Oct 30 06:00:15 volumio volumio[4024]: info: CoreCommandRouter::volumioGetState Oct 30 06:00:15 volumio volumio[4024]: info: CorePlayQueue::getTrack 0 Oct 30 06:00:15 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 30 06:00:16 volumio volumio[4024]: info: Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:16 volumio volumio[4024]: info: Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:16 volumio volumio[4024]: info: Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:16 volumio volumio[4024]: info: Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:16 volumio volumio[4024]: info: Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:16 volumio volumio[4024]: info: Oct 30 06:00:16 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:16 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:16 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:17 volumio volumio[4024]: info: Oct 30 06:00:17 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:17 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:17 volumio volumio[4024]: info: sendMpdCommand status took 9 milliseconds Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:17 volumio volumio[4024]: info: Oct 30 06:00:17 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:17 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:17 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:17 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:17 volumio volumio[4024]: In UPNP mode Oct 30 06:00:17 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:55587/bridge-93.flac","trackType":"flac"} Oct 30 06:00:17 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus stop Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:17 volumio volumio[4024]: info: ------------------------------ 13ms Oct 30 06:00:17 volumio volumio[4024]: info: sendMpdCommand status took 3 milliseconds Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:17 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 30 06:00:17 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:17 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:17 volumio volumio[4024]: In UPNP mode Oct 30 06:00:17 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":365,"duration":230,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1914 Kbps","isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:55587/bridge-93.flac","trackType":"flac"} Oct 30 06:00:17 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:17 volumio volumio[4024]: info: Received an update from plugin. extracting info from payload Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:17 volumio volumio[4024]: info: ------------------------------ 8ms Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:17 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:17 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:17 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:17 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:20 volumio volumio[4024]: info: Oct 30 06:00:20 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:20 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:20 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:20 volumio volumio[4024]: info: sendMpdCommand status took 1 milliseconds Oct 30 06:00:20 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:20 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:20 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:00:20 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:20 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:20 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:20 volumio volumio[4024]: In UPNP mode Oct 30 06:00:20 volumio volumio[4024]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2269,"duration":230,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2846 Kbps","isStreaming":false,"title":"爱与不爱都是伤害","artist":"孙露","album":"另一种情感","uri":"http://192.168.1.17:55587/bridge-93.flac","trackType":"flac"} Oct 30 06:00:20 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::syncState stateService pause Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:20 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:20 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer Oct 30 06:00:20 volumio volumio[4024]: info: ------------------------------ 5ms Oct 30 06:00:20 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:20 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:20 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:24 volumio volumio[4024]: info: Oct 30 06:00:24 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:24 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:24 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:24 volumio volumio[4024]: info: sendMpdCommand status took 0 milliseconds Oct 30 06:00:24 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:24 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:24 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 30 06:00:24 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:24 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:24 volumio volumio[4024]: info: CorePlayQueue::getTrack 0 Oct 30 06:00:24 volumio volumio[4024]: 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://192.168.1.17:55587/bridge-93.flac","trackType":"flac"} Oct 30 06:00:24 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::syncState stateService stop Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer Oct 30 06:00:24 volumio volumio[4024]: info: ------------------------------ 6ms Oct 30 06:00:24 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:24 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:24 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:25 volumio volumio[4024]: info: Clearing queue after UPNP request Oct 30 06:00:25 volumio volumio[4024]: info: CoreStateMachine::ClearQueue Oct 30 06:00:25 volumio volumio[4024]: info: CoreStateMachine::stop Oct 30 06:00:25 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 30 06:00:25 volumio volumio[4024]: UNSET VOLATILE Oct 30 06:00:25 volumio volumio[4024]: info: CorePlayQueue::clearPlayQueue Oct 30 06:00:25 volumio volumio[4024]: info: CorePlayQueue::saveQueue Oct 30 06:00:25 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:25 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:25 volumio volumio[4024]: info: CoreCommandRouter::volumioPushQueue Oct 30 06:00:25 volumio volumio[4024]: info: Oct 30 06:00:25 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:25 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:25 volumio volumio[4024]: error: updateQueue error: null Oct 30 06:00:25 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:25 volumio volumio[4024]: info: Starting UPNP Playback Oct 30 06:00:25 volumio volumio[4024]: info: Preparing playback through UPNP Oct 30 06:00:25 volumio volumio[4024]: info: CoreCommandRouter::volumioGetState Oct 30 06:00:25 volumio volumio[4024]: info: CorePlayQueue::getTrack 0 Oct 30 06:00:25 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 30 06:00:26 volumio volumio[4024]: info: Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:26 volumio volumio[4024]: info: Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:26 volumio volumio[4024]: info: Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:26 volumio volumio[4024]: info: Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:26 volumio volumio[4024]: info: Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 2ms Oct 30 06:00:26 volumio volumio[4024]: info: Oct 30 06:00:26 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:26 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:26 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:33 volumio volumio[4024]: info: Oct 30 06:00:33 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:33 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:33 volumio volumio[4024]: info: Oct 30 06:00:33 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:33 volumio volumio[4024]: info: sendMpdCommand status took 10 milliseconds Oct 30 06:00:33 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:33 volumio volumio[4024]: info: sendMpdCommand status took 0 milliseconds Oct 30 06:00:33 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:33 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:33 volumio volumio[4024]: In UPNP mode Oct 30 06:00:33 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1025 Kbps","isStreaming":false,"title":"驼铃","artist":"刘紫玲","album":"如歌岁月[Remaster]","uri":"http://192.168.1.17:39829/bridge-94.flac","trackType":"flac"} Oct 30 06:00:33 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus stop Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:33 volumio volumio[4024]: info: ------------------------------ 13ms Oct 30 06:00:33 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 30 06:00:33 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:33 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:33 volumio volumio[4024]: In UPNP mode Oct 30 06:00:33 volumio volumio[4024]: verbose: STATE SERVICE {"status":"play","position":0,"seek":458,"duration":287,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1032 Kbps","isStreaming":false,"title":"驼铃","artist":"刘紫玲","album":"如歌岁月[Remaster]","uri":"http://192.168.1.17:39829/bridge-94.flac","trackType":"flac"} Oct 30 06:00:33 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:33 volumio volumio[4024]: info: Received an update from plugin. extracting info from payload Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:33 volumio volumio[4024]: info: ------------------------------ 8ms Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:33 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:33 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:33 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:33 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:34 volumio volumio[4024]: info: Oct 30 06:00:34 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:34 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:34 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:34 volumio volumio[4024]: info: sendMpdCommand status took 0 milliseconds Oct 30 06:00:34 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:34 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:34 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:00:34 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:34 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:34 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:34 volumio volumio[4024]: In UPNP mode Oct 30 06:00:34 volumio volumio[4024]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1480,"duration":287,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1772 Kbps","isStreaming":false,"title":"驼铃","artist":"刘紫玲","album":"如歌岁月[Remaster]","uri":"http://192.168.1.17:39829/bridge-94.flac","trackType":"flac"} Oct 30 06:00:34 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::syncState stateService pause Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:34 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:34 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer Oct 30 06:00:34 volumio volumio[4024]: info: ------------------------------ 3ms Oct 30 06:00:34 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:34 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:34 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:44 volumio volumio[4024]: info: Oct 30 06:00:44 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:44 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:44 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:44 volumio volumio[4024]: info: sendMpdCommand status took 1 milliseconds Oct 30 06:00:44 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:44 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:44 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:00:44 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:44 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:44 volumio volumio[4024]: info: CorePlayQueue::getTrack 0 Oct 30 06:00:44 volumio volumio[4024]: 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":"如歌岁月[Remaster]","uri":"http://192.168.1.17:39829/bridge-94.flac","trackType":"flac"} Oct 30 06:00:44 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::syncState stateService stop Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::stPlaybackTimer Oct 30 06:00:44 volumio volumio[4024]: info: ------------------------------ 5ms Oct 30 06:00:44 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:44 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:44 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:44 volumio volumio[4024]: info: Clearing queue after UPNP request Oct 30 06:00:45 volumio volumio[4024]: info: CoreStateMachine::ClearQueue Oct 30 06:00:45 volumio volumio[4024]: info: CoreStateMachine::stop Oct 30 06:00:45 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 30 06:00:45 volumio volumio[4024]: UNSET VOLATILE Oct 30 06:00:45 volumio volumio[4024]: info: CorePlayQueue::clearPlayQueue Oct 30 06:00:45 volumio volumio[4024]: info: CorePlayQueue::saveQueue Oct 30 06:00:45 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:45 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:45 volumio volumio[4024]: info: CoreCommandRouter::volumioPushQueue Oct 30 06:00:45 volumio volumio[4024]: info: Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:45 volumio volumio[4024]: error: updateQueue error: null Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:45 volumio volumio[4024]: info: Starting UPNP Playback Oct 30 06:00:45 volumio volumio[4024]: info: Preparing playback through UPNP Oct 30 06:00:45 volumio volumio[4024]: info: CoreCommandRouter::volumioGetState Oct 30 06:00:45 volumio volumio[4024]: info: CorePlayQueue::getTrack 0 Oct 30 06:00:45 volumio volumio[4024]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 30 06:00:45 volumio volumio[4024]: info: Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:45 volumio volumio[4024]: info: Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:45 volumio volumio[4024]: info: Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:45 volumio volumio[4024]: info: Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:45 volumio volumio[4024]: info: Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 0ms Oct 30 06:00:45 volumio volumio[4024]: info: Oct 30 06:00:45 volumio volumio[4024]: ---------------------------- MPD announces system playlist update Oct 30 06:00:45 volumio volumio[4024]: info: Ignoring MPD Status Update Oct 30 06:00:45 volumio volumio[4024]: info: ------------------------------ 1ms Oct 30 06:00:46 volumio volumio[4024]: info: Oct 30 06:00:46 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:46 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:46 volumio volumio[4024]: info: sendMpdCommand status took 1 milliseconds Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:46 volumio volumio[4024]: info: Oct 30 06:00:46 volumio volumio[4024]: ---------------------------- MPD announces state update: player Oct 30 06:00:46 volumio volumio[4024]: info: ControllerMpd::getState Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:00:46 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:46 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:46 volumio volumio[4024]: In UPNP mode Oct 30 06:00:46 volumio volumio[4024]: 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":"01. 你看你看月亮的脸","artist":"发烧对唱-那个季节里的歌","album":"童丽VS刘艺-那个季节里的歌5","uri":"http://192.168.1.17:37189/bridge-95.flac","trackType":"flac"} Oct 30 06:00:46 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus stop Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:46 volumio volumio[4024]: info: ------------------------------ 3ms Oct 30 06:00:46 volumio volumio[4024]: info: sendMpdCommand status took 3 milliseconds Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::parseState Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:00:46 volumio volumio[4024]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 30 06:00:46 volumio volumio[4024]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:00:46 volumio volumio[4024]: info: ControllerMpd::pushState Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::servicePushState Oct 30 06:00:46 volumio volumio[4024]: In UPNP mode Oct 30 06:00:46 volumio volumio[4024]: 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":"659 Kbps","isStreaming":false,"title":"01. 你看你看月亮的脸","artist":"发烧对唱-那个季节里的歌","album":"童丽VS刘艺-那个季节里的歌5","uri":"http://192.168.1.17:37189/bridge-95.flac","trackType":"flac"} Oct 30 06:00:46 volumio volumio[4024]: verbose: CURRENT POSITION 0 Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::syncState stateService play Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:00:46 volumio volumio[4024]: info: Received an update from plugin. extracting info from payload Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::pushState Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioPushState Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:00:46 volumio volumio[4024]: info: ------------------------------ 8ms Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:46 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:00:46 volumio volumio[4024]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:00:46 volumio volumio[4024]: info: CoreStateMachine::getQueue Oct 30 06:00:46 volumio volumio[4024]: info: CorePlayQueue::getQueue Oct 30 06:01:04 volumio nmbd[895]: [2025/10/30 06:01:04.523191, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 06:01:04 volumio nmbd[895]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.25 for name WORKGROUP<1d>. Oct 30 06:01:04 volumio nmbd[895]: This response was from IP 192.168.1.20, reporting an IP address of 192.168.1.20. Oct 30 06:01:53 volumio volumio[4024]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 06:01:53 volumio volumio[4024]: { Error: connect ETIMEDOUT 162.125.32.6:443 Oct 30 06:01:53 volumio volumio[4024]: at Object._errnoException (util.js:1022:11) Oct 30 06:01:53 volumio volumio[4024]: at _exceptionWithHostPort (util.js:1044:20) Oct 30 06:01:53 volumio volumio[4024]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 30 06:01:53 volumio volumio[4024]: code: 'ETIMEDOUT', Oct 30 06:01:53 volumio volumio[4024]: errno: 'ETIMEDOUT', Oct 30 06:01:53 volumio volumio[4024]: syscall: 'connect', Oct 30 06:01:53 volumio volumio[4024]: address: '162.125.32.6', Oct 30 06:01:53 volumio volumio[4024]: port: 443 } Oct 30 06:01:53 volumio volumio[4024]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 06:01:53 volumio sudo[28777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-30 06:00 Oct 30 06:01:53 volumio sudo[28777]: 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="537e3f50b5a8aa9bdf42f94adc80b348609b5c47" VOLUMIO_BE_VERSION="d7e6c614214d5dc616fddcbcfefc47e1990da7b1" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 8 12:33:16 CEST 2021" VOLUMIO_VERSION="2.909" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="6e5c976a6d85b8b7d7e4e3388d208cd8"