-- Logs begin at Sat 2025-06-28 06:53:12 UTC, end at Sat 2025-06-28 06:56:57 UTC. -- Jun 28 06:55:02 dh-72 volumio[770]: info: Clearing queue after UPNP request Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::ClearQueue Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::stop Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 06:55:03 dh-72 volumio[770]: verbose: UNSET VOLATILE Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::stPlaybackTimer Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::updateTrackBlock Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::getTrackBlock Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::serviceStop Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:03 dh-72 volumio[770]: info: ControllerMpd::stop Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::clearPlayQueue Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::saveQueue Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushQueue Jun 28 06:55:03 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:55:03 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:03 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:55:03 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:55:03 dh-72 volumio[770]: info: sendMpdCommand stop took 42 milliseconds Jun 28 06:55:03 dh-72 volumio[770]: error: updateQueue error: null Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 14ms Jun 28 06:55:03 dh-72 volumio[770]: info: sendMpdCommand status took 11 milliseconds Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:55:03 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:03 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 06:55:03 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService stop Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:03 dh-72 volumio[770]: info: No code Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 62ms Jun 28 06:55:03 dh-72 volumio[770]: info: Starting UPNP Playback Jun 28 06:55:03 dh-72 volumio[770]: info: Preparing playback through UPNP Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetState Jun 28 06:55:03 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:03 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:03 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 7ms Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:03 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:03 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:03 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:03 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:55:03 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:55:03 dh-72 kernel: [SNDRV]:[atm7059_link_hw_params] ###atm7059_link_hw_params Jun 28 06:55:03 dh-72 kernel: atm7059_dai_hw_params,SNDRV_PCM_FORMAT_S32_LE Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:55:03 dh-72 volumio[770]: info: sendMpdCommand status took 17 milliseconds Jun 28 06:55:03 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:55:03 dh-72 volumio[770]: info: Jun 28 06:55:03 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:03 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:03 dh-72 volumio[770]: info: sendMpdCommand status took 11 milliseconds Jun 28 06:55:03 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 10 milliseconds Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:55:03 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:55:03 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:55:03 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你若成风","artist":"许嵩","album":"乐酷","uri":"http://m7.music.126.net/20250628152002/a556d28fd68d2e736d8ebd4a1a35cf07/ymusic/f057/5618/8f51/8c3b819649bc0179d9886849e73815cd.mp3?vuutv=kTaQ5EH8CXCLqZ4Cv3+CQFq1Nm1UDtS8AmC4rXntZ6UL/Dg7yc8lMR5KLBMvNm5bXFnF3M67RxbqKNsM63W6y0GZdeNov2q704QE2WKPq28=","trackType":""} Jun 28 06:55:03 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 68ms Jun 28 06:55:03 dh-72 volumio[770]: info: ------------------------------ 39ms Jun 28 06:55:03 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 32 milliseconds Jun 28 06:55:03 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:55:03 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:55:03 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:55:03 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104,"duration":222,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你若成风","artist":"许嵩","album":"乐酷","uri":"http://m7.music.126.net/20250628152002/a556d28fd68d2e736d8ebd4a1a35cf07/ymusic/f057/5618/8f51/8c3b819649bc0179d9886849e73815cd.mp3?vuutv=kTaQ5EH8CXCLqZ4Cv3+CQFq1Nm1UDtS8AmC4rXntZ6UL/Dg7yc8lMR5KLBMvNm5bXFnF3M67RxbqKNsM63W6y0GZdeNov2q704QE2WKPq28=","trackType":""} Jun 28 06:55:03 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:55:03 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus play Jun 28 06:55:03 dh-72 volumio[770]: info: Received an update from plugin. extracting info from payload Jun 28 06:55:03 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 06:55:04 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:04 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:04 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:04 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:04 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:04 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:04 dh-72 volumio[770]: info: ------------------------------ 93ms Jun 28 06:55:04 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:04 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:04 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:55:04 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:04 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:04 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:55:04 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:04 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:04 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:55:19 dh-72 volumio[770]: info: Clearing queue after UPNP request Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::ClearQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::stop Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 06:55:19 dh-72 volumio[770]: verbose: UNSET VOLATILE Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::stPlaybackTimer Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::updateTrackBlock Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::getTrackBlock Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::serviceStop Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:19 dh-72 volumio[770]: info: ControllerMpd::stop Jun 28 06:55:19 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::clearPlayQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::saveQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushQueue Jun 28 06:55:19 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:55:19 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:55:19 dh-72 volumio[770]: info: Jun 28 06:55:19 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:19 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:19 dh-72 volumio[770]: info: Jun 28 06:55:19 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:55:19 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:55:19 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:55:19 dh-72 volumio[770]: info: sendMpdCommand stop took 59 milliseconds Jun 28 06:55:19 dh-72 volumio[770]: info: Starting UPNP Playback Jun 28 06:55:19 dh-72 volumio[770]: info: Preparing playback through UPNP Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetState Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 28 06:55:19 dh-72 volumio[770]: error: updateQueue error: null Jun 28 06:55:19 dh-72 volumio[770]: info: ------------------------------ 11ms Jun 28 06:55:19 dh-72 volumio[770]: info: sendMpdCommand status took 9 milliseconds Jun 28 06:55:19 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:55:19 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:55:19 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 06:55:19 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService stop Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:19 dh-72 volumio[770]: info: No code Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:19 dh-72 volumio[770]: info: ------------------------------ 47ms Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:19 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:55:20 dh-72 volumio[770]: info: Jun 28 06:55:20 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:20 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:20 dh-72 volumio[770]: info: Jun 28 06:55:20 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:20 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:20 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:55:20 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:55:20 dh-72 volumio[770]: info: Jun 28 06:55:20 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:20 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:20 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:55:20 dh-72 volumio[770]: info: Jun 28 06:55:20 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:20 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:20 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:55:20 dh-72 volumio[770]: info: Jun 28 06:55:20 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:20 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:20 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:55:20 dh-72 volumio[770]: info: Jun 28 06:55:20 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:55:20 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:55:20 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:55:23 dh-72 volumio[770]: info: Jun 28 06:55:23 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:55:23 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:55:23 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:55:23 dh-72 kernel: [SNDRV]:[atm7059_link_hw_params] ###atm7059_link_hw_params Jun 28 06:55:23 dh-72 kernel: atm7059_dai_hw_params,SNDRV_PCM_FORMAT_S32_LE Jun 28 06:55:23 dh-72 volumio[770]: info: sendMpdCommand status took 14 milliseconds Jun 28 06:55:23 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:55:23 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:55:23 dh-72 volumio[770]: info: Jun 28 06:55:23 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:55:23 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:55:23 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:55:23 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 28 06:55:23 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:55:23 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:55:23 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:55:23 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"心之火","artist":"张叶蕾","album":"心之火","uri":"http://m701.music.126.net/20250628152019/6cf454ded2c6295ef87ccdf0ed3f18eb/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/44804266870/c6b9/dae0/e334/ff980c81c83f95e08c776c3be0e42b1a.mp3?vuutv=FTHMxdG2Fw2V4yqjHP5QFoWMOVwdLA721sEC2O+kV5NDbexecNI88iY+Rr9UolbaPhPzOJ45eoR8UsXsdcuW1/u1HI46xMdOb1cR3OPwjxg=","trackType":""} Jun 28 06:55:23 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:23 dh-72 volumio[770]: info: ------------------------------ 63ms Jun 28 06:55:23 dh-72 volumio[770]: info: sendMpdCommand status took 40 milliseconds Jun 28 06:55:23 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:55:23 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:23 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:55:23 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 28 06:55:23 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:55:23 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:55:23 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:55:23 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":160,"duration":206,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"心之火","artist":"张叶蕾","album":"心之火","uri":"http://m701.music.126.net/20250628152019/6cf454ded2c6295ef87ccdf0ed3f18eb/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/44804266870/c6b9/dae0/e334/ff980c81c83f95e08c776c3be0e42b1a.mp3?vuutv=FTHMxdG2Fw2V4yqjHP5QFoWMOVwdLA721sEC2O+kV5NDbexecNI88iY+Rr9UolbaPhPzOJ45eoR8UsXsdcuW1/u1HI46xMdOb1cR3OPwjxg=","trackType":""} Jun 28 06:55:23 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus play Jun 28 06:55:23 dh-72 volumio[770]: info: Received an update from plugin. extracting info from payload Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:55:23 dh-72 volumio[770]: info: ------------------------------ 93ms Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:23 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:55:23 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:55:23 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:55:23 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:01 dh-72 volumio[770]: info: Clearing queue after UPNP request Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::ClearQueue Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::stop Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 06:56:02 dh-72 volumio[770]: verbose: UNSET VOLATILE Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::stPlaybackTimer Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::updateTrackBlock Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::getTrackBlock Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::serviceStop Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:02 dh-72 volumio[770]: info: ControllerMpd::stop Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::clearPlayQueue Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::saveQueue Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushQueue Jun 28 06:56:02 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:02 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:02 dh-72 volumio[770]: info: sendMpdCommand stop took 34 milliseconds Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:02 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:02 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:02 dh-72 volumio[770]: info: sendMpdCommand status took 5 milliseconds Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:02 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:02 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 06:56:02 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService stop Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:02 dh-72 volumio[770]: info: No code Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 66ms Jun 28 06:56:02 dh-72 volumio[770]: info: Starting UPNP Playback Jun 28 06:56:02 dh-72 volumio[770]: info: Preparing playback through UPNP Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetState Jun 28 06:56:02 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 28 06:56:02 dh-72 volumio[770]: error: updateQueue error: null Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 71ms Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:02 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:02 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 7ms Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:02 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:02 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:02 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:02 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:02 dh-72 kernel: [SNDRV]:[atm7059_link_hw_params] ###atm7059_link_hw_params Jun 28 06:56:02 dh-72 kernel: atm7059_dai_hw_params,SNDRV_PCM_FORMAT_S32_LE Jun 28 06:56:02 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:02 dh-72 volumio[770]: info: Jun 28 06:56:02 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:02 dh-72 volumio[770]: info: sendMpdCommand status took 15 milliseconds Jun 28 06:56:02 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:02 dh-72 volumio[770]: info: sendMpdCommand status took 6 milliseconds Jun 28 06:56:02 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:02 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:02 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:02 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"过客","artist":"周思涵","album":"过客","uri":"http://m701.music.126.net/20250628152101/879da15de8f5c94c8691e60a8bee8e78/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/28481687766/e7ce/124a/534a/99299dc889015e1480100efa2ce27864.mp3?vuutv=7mjklyDG4vGWXYf2IVSNl/fJlRMv3qEhkgKDkgzw1vtOl3ZDxKB1Xd6AdoR0F+KKGh2P69XAi2RHwsXrG+sNxVjbvMeVViSntaBroenp0o4=","trackType":""} Jun 28 06:56:02 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 56ms Jun 28 06:56:02 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 30 milliseconds Jun 28 06:56:02 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:02 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:02 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:02 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"过客","artist":"周思涵","album":"过客","uri":"http://m701.music.126.net/20250628152101/879da15de8f5c94c8691e60a8bee8e78/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/28481687766/e7ce/124a/534a/99299dc889015e1480100efa2ce27864.mp3?vuutv=7mjklyDG4vGWXYf2IVSNl/fJlRMv3qEhkgKDkgzw1vtOl3ZDxKB1Xd6AdoR0F+KKGh2P69XAi2RHwsXrG+sNxVjbvMeVViSntaBroenp0o4=","trackType":""} Jun 28 06:56:02 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus play Jun 28 06:56:02 dh-72 volumio[770]: info: Received an update from plugin. extracting info from payload Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:02 dh-72 volumio[770]: info: ------------------------------ 81ms Jun 28 06:56:02 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:02 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:03 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:03 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:03 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:03 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:03 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:03 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:16 dh-72 volumio[770]: info: Clearing queue after UPNP request Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::ClearQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::stop Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 06:56:16 dh-72 volumio[770]: verbose: UNSET VOLATILE Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::stPlaybackTimer Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::updateTrackBlock Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::getTrackBlock Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::serviceStop Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:16 dh-72 volumio[770]: info: ControllerMpd::stop Jun 28 06:56:16 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::clearPlayQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::saveQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushQueue Jun 28 06:56:16 dh-72 volumio[770]: info: Jun 28 06:56:16 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:16 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:16 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:16 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:16 dh-72 volumio[770]: info: Jun 28 06:56:16 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:16 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:16 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:16 dh-72 volumio[770]: info: sendMpdCommand stop took 59 milliseconds Jun 28 06:56:16 dh-72 volumio[770]: info: Starting UPNP Playback Jun 28 06:56:16 dh-72 volumio[770]: info: Preparing playback through UPNP Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetState Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 28 06:56:16 dh-72 volumio[770]: error: updateQueue error: null Jun 28 06:56:16 dh-72 volumio[770]: info: ------------------------------ 12ms Jun 28 06:56:16 dh-72 volumio[770]: info: sendMpdCommand status took 8 milliseconds Jun 28 06:56:16 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:16 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:16 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 06:56:16 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService stop Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:16 dh-72 volumio[770]: info: No code Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:16 dh-72 volumio[770]: info: ------------------------------ 46ms Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:16 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:16 dh-72 volumio[770]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%80%9D%E6%B6%B5/%E8%BF%87%E5%AE%A2/c6273235-c661-453b-ad0b-969b53e28093.jpg' Jun 28 06:56:17 dh-72 volumio[770]: info: Jun 28 06:56:17 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:17 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:17 dh-72 volumio[770]: info: Jun 28 06:56:17 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:17 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:17 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:56:17 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:17 dh-72 volumio[770]: info: Jun 28 06:56:17 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:17 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:17 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:17 dh-72 volumio[770]: info: Jun 28 06:56:17 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:17 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:17 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:17 dh-72 volumio[770]: info: Jun 28 06:56:17 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:17 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:17 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:56:17 dh-72 volumio[770]: info: Jun 28 06:56:17 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:17 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:17 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:17 dh-72 volumio[770]: info: Jun 28 06:56:17 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:17 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:17 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:17 dh-72 kernel: [SNDRV]:[atm7059_link_hw_params] ###atm7059_link_hw_params Jun 28 06:56:17 dh-72 kernel: atm7059_dai_hw_params,SNDRV_PCM_FORMAT_S32_LE Jun 28 06:56:17 dh-72 volumio[770]: info: Jun 28 06:56:17 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:17 dh-72 volumio[770]: info: sendMpdCommand status took 14 milliseconds Jun 28 06:56:17 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:17 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:17 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:17 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:17 dh-72 volumio[770]: info: sendMpdCommand status took 6 milliseconds Jun 28 06:56:17 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 28 06:56:17 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:17 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:17 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:17 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:17 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:17 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"过客","artist":"周思涵","album":"过客","uri":"http://m701.music.126.net/20250628152116/05afeb7ac3fb3681f003c87b3cde8002/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/28481687766/e7ce/124a/534a/99299dc889015e1480100efa2ce27864.mp3?vuutv=K1wro/X3ZMbejP9tseE072mh6LjO1BRpDWPjyVxJLDL+A6tW/0smShJ05rn2RSofBHl52w2YlmHw/DvQxE4bbUprXAEMJ3DUnsx5BAw9B+M=","trackType":""} Jun 28 06:56:17 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:17 dh-72 volumio[770]: info: ------------------------------ 56ms Jun 28 06:56:17 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 27 milliseconds Jun 28 06:56:17 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:17 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:17 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:17 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"过客","artist":"周思涵","album":"过客","uri":"http://m701.music.126.net/20250628152116/05afeb7ac3fb3681f003c87b3cde8002/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/28481687766/e7ce/124a/534a/99299dc889015e1480100efa2ce27864.mp3?vuutv=K1wro/X3ZMbejP9tseE072mh6LjO1BRpDWPjyVxJLDL+A6tW/0smShJ05rn2RSofBHl52w2YlmHw/DvQxE4bbUprXAEMJ3DUnsx5BAw9B+M=","trackType":""} Jun 28 06:56:17 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus play Jun 28 06:56:17 dh-72 volumio[770]: info: Received an update from plugin. extracting info from payload Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:17 dh-72 volumio[770]: info: ------------------------------ 81ms Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:17 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:17 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:17 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:17 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:17 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:20 dh-72 volumio[770]: info: Clearing queue after UPNP request Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::ClearQueue Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::stop Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 06:56:20 dh-72 volumio[770]: verbose: UNSET VOLATILE Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::stPlaybackTimer Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::updateTrackBlock Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::getTrackBlock Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::serviceStop Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:20 dh-72 volumio[770]: info: ControllerMpd::stop Jun 28 06:56:20 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::clearPlayQueue Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::saveQueue Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushQueue Jun 28 06:56:20 dh-72 volumio[770]: info: Jun 28 06:56:20 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:20 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:20 dh-72 volumio[770]: info: Jun 28 06:56:20 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:20 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:20 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:20 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:20 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:20 dh-72 volumio[770]: info: sendMpdCommand stop took 54 milliseconds Jun 28 06:56:20 dh-72 volumio[770]: error: updateQueue error: null Jun 28 06:56:20 dh-72 volumio[770]: info: ------------------------------ 11ms Jun 28 06:56:20 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 28 06:56:20 dh-72 volumio[770]: info: sendMpdCommand status took 13 milliseconds Jun 28 06:56:20 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:20 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:20 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 06:56:20 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService stop Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:20 dh-72 volumio[770]: info: No code Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:20 dh-72 volumio[770]: info: ------------------------------ 51ms Jun 28 06:56:20 dh-72 volumio[770]: info: Starting UPNP Playback Jun 28 06:56:20 dh-72 volumio[770]: info: Preparing playback through UPNP Jun 28 06:56:20 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetState Jun 28 06:56:20 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:20 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 28 06:56:20 dh-72 volumio[770]: info: sendMpdCommand clearerror took 41 milliseconds Jun 28 06:56:21 dh-72 volumio[770]: info: Jun 28 06:56:21 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:21 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:21 dh-72 volumio[770]: info: Jun 28 06:56:21 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:21 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:21 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:56:21 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:21 dh-72 volumio[770]: info: Jun 28 06:56:21 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:21 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:21 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:21 dh-72 volumio[770]: info: Jun 28 06:56:21 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:21 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:21 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:21 dh-72 volumio[770]: info: Jun 28 06:56:21 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:21 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:21 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:21 dh-72 volumio[770]: info: Jun 28 06:56:21 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:21 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:21 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:23 dh-72 kernel: [SNDRV]:[atm7059_link_hw_params] ###atm7059_link_hw_params Jun 28 06:56:23 dh-72 kernel: atm7059_dai_hw_params,SNDRV_PCM_FORMAT_S32_LE Jun 28 06:56:23 dh-72 volumio[770]: info: Jun 28 06:56:23 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:23 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:23 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:23 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 28 06:56:23 dh-72 volumio[770]: info: sendMpdCommand status took 14 milliseconds Jun 28 06:56:23 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:23 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:23 dh-72 volumio[770]: info: sendMpdCommand clearerror took 10 milliseconds Jun 28 06:56:23 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 28 06:56:23 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:23 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:23 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:23 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:23 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"过客","artist":"周思涵","album":"过客","uri":"http://m801.music.126.net/20250628152120/a1edbc6d0bb0c08dd9a75fcba9e89b27/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/28481687766/e7ce/124a/534a/99299dc889015e1480100efa2ce27864.mp3?vuutv=e8KIpuqANFy10Sl/FLECHiZdcFN+4d2dzEBiItKAyxnhuffgOz6+VNxmFQ2Vv6ymVL7mLevcddVcrLo6WFnSk2+Hj99cqVQZLw96xl7i6S8=","trackType":""} Jun 28 06:56:23 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:23 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:23 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:23 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:23 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:23 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:23 dh-72 volumio[770]: info: ------------------------------ 64ms Jun 28 06:56:23 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:23 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:23 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:24 dh-72 volumio[770]: info: Clearing queue after UPNP request Jun 28 06:56:24 dh-72 volumio[770]: info: CoreStateMachine::ClearQueue Jun 28 06:56:24 dh-72 volumio[770]: info: CoreStateMachine::stop Jun 28 06:56:24 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 06:56:24 dh-72 volumio[770]: verbose: UNSET VOLATILE Jun 28 06:56:24 dh-72 volumio[770]: info: CoreStateMachine::stPlaybackTimer Jun 28 06:56:24 dh-72 volumio[770]: info: CoreStateMachine::updateTrackBlock Jun 28 06:56:24 dh-72 volumio[770]: info: CorePlayQueue::getTrackBlock Jun 28 06:56:24 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:24 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:24 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:24 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:24 dh-72 volumio[770]: info: CoreStateMachine::serviceStop Jun 28 06:56:24 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:24 dh-72 volumio[770]: info: ControllerMpd::stop Jun 28 06:56:24 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 06:56:24 dh-72 volumio[770]: info: CorePlayQueue::clearPlayQueue Jun 28 06:56:24 dh-72 volumio[770]: info: CorePlayQueue::saveQueue Jun 28 06:56:24 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:24 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:24 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushQueue Jun 28 06:56:24 dh-72 volumio[770]: info: Jun 28 06:56:24 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:24 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:24 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:24 dh-72 volumio[770]: info: sendMpdCommand stop took 38 milliseconds Jun 28 06:56:24 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:24 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:24 dh-72 volumio[770]: info: Jun 28 06:56:24 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:24 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:24 dh-72 volumio[770]: info: sendMpdCommand status took 6 milliseconds Jun 28 06:56:24 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:24 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:24 dh-72 volumio[770]: error: updateQueue error: null Jun 28 06:56:24 dh-72 volumio[770]: info: ------------------------------ 9ms Jun 28 06:56:24 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 28 06:56:24 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:24 dh-72 volumio[770]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 28 06:56:24 dh-72 volumio[770]: info: ------------------------------ 21ms Jun 28 06:56:24 dh-72 volumio[770]: info: Starting UPNP Playback Jun 28 06:56:24 dh-72 volumio[770]: info: Preparing playback through UPNP Jun 28 06:56:24 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetState Jun 28 06:56:24 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:24 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 28 06:56:24 dh-72 volumio[770]: info: Jun 28 06:56:24 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:24 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:24 dh-72 volumio[770]: info: Jun 28 06:56:24 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:24 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:24 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:56:24 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:24 dh-72 volumio[770]: info: Jun 28 06:56:24 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:24 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:24 dh-72 volumio[770]: info: ------------------------------ 4ms Jun 28 06:56:24 dh-72 volumio[770]: info: Jun 28 06:56:24 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:24 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:24 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:24 dh-72 volumio[770]: info: Jun 28 06:56:24 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:24 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:24 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:24 dh-72 volumio[770]: info: Jun 28 06:56:24 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:24 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:24 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:56:25 dh-72 volumio[770]: info: Jun 28 06:56:25 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:25 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:25 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:25 dh-72 kernel: [SNDRV]:[atm7059_link_hw_params] ###atm7059_link_hw_params Jun 28 06:56:25 dh-72 kernel: atm7059_dai_hw_params,SNDRV_PCM_FORMAT_S32_LE Jun 28 06:56:25 dh-72 volumio[770]: info: sendMpdCommand status took 14 milliseconds Jun 28 06:56:25 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:25 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:25 dh-72 volumio[770]: info: Jun 28 06:56:25 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:25 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:25 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:25 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 28 06:56:25 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:25 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:25 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:25 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"四季予你","artist":"程响","album":"四季予你","uri":"http://m801.music.126.net/20250628152124/1a89c08ed912d03315f888e59e911fcf/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/29769733847/80bb/b8f0/1783/1facc76e0099f2c333eb136068aa8124.mp3?vuutv=272TXXuC7OA3iwMjlxoMz1CLfgGeYfdncPlk5uqKjAW2Gq4X2KHRkfMBdDlRYDFUACusuOWZ80BraUO3Sy+GiRcOaem/WC07e0WfazgWLec=","trackType":""} Jun 28 06:56:25 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:25 dh-72 volumio[770]: info: ------------------------------ 61ms Jun 28 06:56:25 dh-72 volumio[770]: info: sendMpdCommand status took 39 milliseconds Jun 28 06:56:25 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:25 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:25 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:25 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 13 milliseconds Jun 28 06:56:25 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:25 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:25 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:25 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"四季予你","artist":"程响","album":"四季予你","uri":"http://m801.music.126.net/20250628152124/1a89c08ed912d03315f888e59e911fcf/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/29769733847/80bb/b8f0/1783/1facc76e0099f2c333eb136068aa8124.mp3?vuutv=272TXXuC7OA3iwMjlxoMz1CLfgGeYfdncPlk5uqKjAW2Gq4X2KHRkfMBdDlRYDFUACusuOWZ80BraUO3Sy+GiRcOaem/WC07e0WfazgWLec=","trackType":""} Jun 28 06:56:25 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus play Jun 28 06:56:25 dh-72 volumio[770]: info: Received an update from plugin. extracting info from payload Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:25 dh-72 volumio[770]: info: ------------------------------ 93ms Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:25 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:25 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:25 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:25 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:32 dh-72 volumio[770]: info: Clearing queue after UPNP request Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::ClearQueue Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::stop Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 06:56:32 dh-72 volumio[770]: verbose: UNSET VOLATILE Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::stPlaybackTimer Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::updateTrackBlock Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::getTrackBlock Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::serviceStop Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:32 dh-72 volumio[770]: info: ControllerMpd::stop Jun 28 06:56:32 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::clearPlayQueue Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::saveQueue Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushQueue Jun 28 06:56:32 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:32 dh-72 kernel: [SNDRV]:[atc2603c_audio_hw_free] atc2603c_audio_hw_free Jun 28 06:56:32 dh-72 volumio[770]: info: Jun 28 06:56:32 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:32 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:32 dh-72 volumio[770]: info: Jun 28 06:56:32 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:32 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:32 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:32 dh-72 volumio[770]: info: sendMpdCommand stop took 34 milliseconds Jun 28 06:56:32 dh-72 volumio[770]: error: updateQueue error: null Jun 28 06:56:32 dh-72 volumio[770]: info: ------------------------------ 8ms Jun 28 06:56:32 dh-72 volumio[770]: info: sendMpdCommand status took 6 milliseconds Jun 28 06:56:32 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:32 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:32 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 06:56:32 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService stop Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:32 dh-72 volumio[770]: info: No code Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:32 dh-72 volumio[770]: info: ------------------------------ 51ms Jun 28 06:56:32 dh-72 volumio[770]: info: Starting UPNP Playback Jun 28 06:56:32 dh-72 volumio[770]: info: Preparing playback through UPNP Jun 28 06:56:32 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetState Jun 28 06:56:32 dh-72 volumio[770]: info: CorePlayQueue::getTrack 0 Jun 28 06:56:32 dh-72 volumio[770]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 28 06:56:33 dh-72 volumio[770]: info: Jun 28 06:56:33 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:33 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:33 dh-72 volumio[770]: info: Jun 28 06:56:33 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:33 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:33 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:56:33 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:33 dh-72 volumio[770]: info: Jun 28 06:56:33 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:33 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:33 dh-72 volumio[770]: info: ------------------------------ 9ms Jun 28 06:56:33 dh-72 volumio[770]: info: Jun 28 06:56:33 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:33 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:33 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:56:33 dh-72 volumio[770]: info: Jun 28 06:56:33 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:33 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:33 dh-72 volumio[770]: info: ------------------------------ 6ms Jun 28 06:56:33 dh-72 volumio[770]: info: Jun 28 06:56:33 dh-72 volumio[770]: ---------------------------- MPD announces system playlist update Jun 28 06:56:33 dh-72 volumio[770]: info: Ignoring MPD Status Update Jun 28 06:56:33 dh-72 volumio[770]: info: ------------------------------ 5ms Jun 28 06:56:33 dh-72 volumio[770]: info: Jun 28 06:56:33 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:33 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:33 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:33 dh-72 kernel: [SNDRV]:[atm7059_link_hw_params] ###atm7059_link_hw_params Jun 28 06:56:33 dh-72 kernel: atm7059_dai_hw_params,SNDRV_PCM_FORMAT_S32_LE Jun 28 06:56:33 dh-72 volumio[770]: info: Jun 28 06:56:33 dh-72 volumio[770]: ---------------------------- MPD announces state update: player Jun 28 06:56:33 dh-72 volumio[770]: info: sendMpdCommand status took 16 milliseconds Jun 28 06:56:33 dh-72 volumio[770]: info: ControllerMpd::getState Jun 28 06:56:33 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand status Jun 28 06:56:33 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:33 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:33 dh-72 volumio[770]: info: sendMpdCommand status took 6 milliseconds Jun 28 06:56:33 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 28 06:56:33 dh-72 volumio[770]: verbose: ControllerMpd::parseState Jun 28 06:56:33 dh-72 volumio[770]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 06:56:33 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:33 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:33 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:33 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"四季予你","artist":"程响","album":"四季予你","uri":"http://m801.music.126.net/20250628152132/2fa9530acccb16d9a99905d5ff1ed173/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/29769733847/80bb/b8f0/1783/1facc76e0099f2c333eb136068aa8124.mp3?vuutv=7nD//up37NR6Je4qu/lCL0J59it5kGbxpkEPXhRHAmdazY7S2C0koEf8I/yimj5fo0CQieSTXc159pL7qdNorGmoqhNZlsY3psf0xs9RtWU=","trackType":""} Jun 28 06:56:33 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus stop Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:33 dh-72 volumio[770]: info: ------------------------------ 55ms Jun 28 06:56:33 dh-72 volumio[770]: info: sendMpdCommand playlistinfo took 25 milliseconds Jun 28 06:56:33 dh-72 volumio[770]: verbose: ControllerMpd::parseTrackInfo Jun 28 06:56:33 dh-72 volumio[770]: info: ControllerMpd::pushState Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::servicePushState Jun 28 06:56:33 dh-72 volumio[770]: verbose: In UPNP mode Jun 28 06:56:33 dh-72 volumio[770]: verbose: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"四季予你","artist":"程响","album":"四季予你","uri":"http://m801.music.126.net/20250628152132/2fa9530acccb16d9a99905d5ff1ed173/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/29769733847/80bb/b8f0/1783/1facc76e0099f2c333eb136068aa8124.mp3?vuutv=7nD//up37NR6Je4qu/lCL0J59it5kGbxpkEPXhRHAmdazY7S2C0koEf8I/yimj5fo0CQieSTXc159pL7qdNorGmoqhNZlsY3psf0xs9RtWU=","trackType":""} Jun 28 06:56:33 dh-72 volumio[770]: verbose: CURRENT POSITION 0 Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::syncState stateService play Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::syncState currentStatus play Jun 28 06:56:33 dh-72 volumio[770]: info: Received an update from plugin. extracting info from payload Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::pushState Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::volumioPushState Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 06:56:33 dh-72 volumio[770]: info: ------------------------------ 82ms Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:33 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:33 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:33 dh-72 volumio[770]: info: CoreCommandRouter::volumioGetQueue Jun 28 06:56:33 dh-72 volumio[770]: info: CoreStateMachine::getQueue Jun 28 06:56:33 dh-72 volumio[770]: info: CorePlayQueue::getQueue Jun 28 06:56:33 dh-72 volumio[770]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%A8%8B%E5%93%8D/%E5%9B%9B%E5%AD%A3%E4%BA%88%E4%BD%A0/012bc586-8eb4-43e4-8d82-93034323feb8.jpg' Jun 28 06:56:56 dh-72 volumio[770]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 06:56:56 dh-72 volumio[770]: { Error: connect ETIMEDOUT 31.13.96.208:443 Jun 28 06:56:56 dh-72 volumio[770]: at Object._errnoException (util.js:1022:11) Jun 28 06:56:56 dh-72 volumio[770]: at _exceptionWithHostPort (util.js:1044:20) Jun 28 06:56:56 dh-72 volumio[770]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 28 06:56:56 dh-72 volumio[770]: code: 'ETIMEDOUT', Jun 28 06:56:56 dh-72 volumio[770]: errno: 'ETIMEDOUT', Jun 28 06:56:56 dh-72 volumio[770]: syscall: 'connect', Jun 28 06:56:56 dh-72 volumio[770]: address: '31.13.96.208', Jun 28 06:56:56 dh-72 volumio[770]: port: 443 } Jun 28 06:56:56 dh-72 volumio[770]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 06:56:57 dh-72 sudo[1820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-28 06:55 Jun 28 06:56:57 dh-72 sudo[1820]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 12:12:00 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="sparky" VOLUMIO_HASH="1507c65028120e16c14994c066bc5dd4"