-- Logs begin at Mon 2025-04-14 22:10:05 CST, end at Wed 2025-04-16 20:30:53 CST. -- Apr 16 20:29:00 lp volumio[1164]: info: Apr 16 20:29:00 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:29:00 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:29:00 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:29:00 lp volumio[1164]: info: sendMpdCommand status took 3 milliseconds Apr 16 20:29:00 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:29:00 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:29:00 lp volumio[1164]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 16 20:29:00 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:29:00 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:29:00 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:29:00 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:29:00 lp volumio[1164]: info: CorePlayQueue::getTrack 0 Apr 16 20:29:00 lp volumio[1164]: 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://aqqmusic.tc.qq.com/F0000004Gi6j1D3pYs.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=7F5F26918F7EDACCBE6DA786BD811B2240DA1ADBD1C4B003229B63D550B6F350461750D709C2E41BF04394671C6E80986D5C09ABA06180DC__v21e2a1873&uin=1152921504891883214&redirect=1&fromtag=111114","trackType":""} Apr 16 20:29:00 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::syncState stateService stop Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus play Apr 16 20:29:00 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::stPlaybackTimer Apr 16 20:29:00 lp volumio[1164]: info: ------------------------------ 26ms Apr 16 20:29:00 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:29:00 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:29:00 lp volumio[1164]: info: Clearing queue after UPNP request Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::ClearQueue Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::stop Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 20:29:00 lp volumio[1164]: info: CorePlayQueue::clearPlayQueue Apr 16 20:29:00 lp volumio[1164]: info: CorePlayQueue::saveQueue Apr 16 20:29:00 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:29:00 lp volumio[1164]: info: CoreCommandRouter::volumioPushQueue Apr 16 20:29:00 lp volumio[1164]: info: Apr 16 20:29:00 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:29:00 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:29:00 lp volumio[1164]: error: updateQueue error: null Apr 16 20:29:00 lp volumio[1164]: info: ------------------------------ 4ms Apr 16 20:29:00 lp volumio[1164]: info: Starting UPNP Playback Apr 16 20:29:00 lp volumio[1164]: info: Preparing playback through UPNP Apr 16 20:29:00 lp volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 16 20:29:00 lp volumio[1164]: info: CorePlayQueue::getTrack 0 Apr 16 20:29:00 lp volumio[1164]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:29:01 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:29:01 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 4ms Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:29:01 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 4ms Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:29:01 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 4ms Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:29:01 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:29:01 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 2ms Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:29:01 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:29:01 lp volumio[1164]: info: sendMpdCommand status took 6 milliseconds Apr 16 20:29:01 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:29:01 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:29:01 lp volumio[1164]: info: Apr 16 20:29:01 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:29:01 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:29:01 lp volumio[1164]: info: sendMpdCommand status took 7 milliseconds Apr 16 20:29:01 lp volumio[1164]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:29:01 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:29:01 lp volumio[1164]: verbose: In UPNP mode Apr 16 20:29:01 lp volumio[1164]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"约定","artist":"童丽","album":"每一个晚上","uri":"http://aqqmusic.tc.qq.com/F000003SYpJ70Bg0GJ.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=0847707FDE87CCF611F26D63771A5D02A21BF1A04CB4B5ABD4427210AC5EB43D4D0977EE8F4150C957FC85CA0533CE671C63B324A0C6C0E6__v2b9ab34b&uin=1152921504891883214&src=F000004f1P5j3W9YEP.flac&redirect=1&fromtag=111114","trackType":""} Apr 16 20:29:01 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::syncState stateService play Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus stop Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 25ms Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 15ms Apr 16 20:29:01 lp volumio[1164]: info: sendMpdCommand status took 14 milliseconds Apr 16 20:29:01 lp volumio[1164]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:29:01 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:29:01 lp volumio[1164]: verbose: In UPNP mode Apr 16 20:29:01 lp volumio[1164]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"约定","artist":"童丽","album":"每一个晚上","uri":"http://aqqmusic.tc.qq.com/F000003SYpJ70Bg0GJ.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=0847707FDE87CCF611F26D63771A5D02A21BF1A04CB4B5ABD4427210AC5EB43D4D0977EE8F4150C957FC85CA0533CE671C63B324A0C6C0E6__v2b9ab34b&uin=1152921504891883214&src=F000004f1P5j3W9YEP.flac&redirect=1&fromtag=111114","trackType":""} Apr 16 20:29:01 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::syncState stateService play Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus play Apr 16 20:29:01 lp volumio[1164]: info: Received an update from plugin. extracting info from payload Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 60ms Apr 16 20:29:01 lp volumio[1164]: info: sendMpdCommand playlistinfo took 35 milliseconds Apr 16 20:29:01 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:29:01 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:29:01 lp volumio[1164]: verbose: In UPNP mode Apr 16 20:29:01 lp volumio[1164]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"约定","artist":"童丽","album":"每一个晚上","uri":"http://aqqmusic.tc.qq.com/F000003SYpJ70Bg0GJ.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=0847707FDE87CCF611F26D63771A5D02A21BF1A04CB4B5ABD4427210AC5EB43D4D0977EE8F4150C957FC85CA0533CE671C63B324A0C6C0E6__v2b9ab34b&uin=1152921504891883214&src=F000004f1P5j3W9YEP.flac&redirect=1&fromtag=111114","trackType":""} Apr 16 20:29:01 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::syncState stateService play Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus play Apr 16 20:29:01 lp volumio[1164]: info: Received an update from plugin. extracting info from payload Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:29:01 lp volumio[1164]: info: ------------------------------ 84ms Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:29:01 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:29:01 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:29:01 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:29:01 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:29:01 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:29:01 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:29:38 lp volumio[1164]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Apr 16 20:29:38 lp sudo[22220]: volumio : unable to resolve host lp Apr 16 20:29:38 lp sudo[22220]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 16 20:29:38 lp sudo[22220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 16 20:29:38 lp sudo[22220]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 20:29:38 lp sudo[22220]: pam_unix(sudo:session): session closed for user root Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 20:29:38 lp sudo[22222]: volumio : unable to resolve host lp Apr 16 20:29:38 lp sudo[22222]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 16 20:29:38 lp sudo[22222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 16 20:29:38 lp sudo[22222]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 20:29:38 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 20:29:38 lp volumio[1164]: info: MPD Permissions set Apr 16 20:29:38 lp systemd[1]: Stopping Music Player Daemon... Apr 16 20:29:38 lp systemd[1]: mpd.service: Succeeded. Apr 16 20:29:38 lp systemd[1]: Stopped Music Player Daemon. Apr 16 20:29:38 lp systemd[1]: Starting Music Player Daemon... Apr 16 20:29:39 lp sudo[22230]: root : unable to resolve host lp Apr 16 20:29:39 lp sudo[22230]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 16 20:29:39 lp sudo[22230]: sudo: unable to resolve host lp: System error Apr 16 20:29:39 lp sudo[22230]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 16 20:29:39 lp sudo[22230]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 20:29:39 lp sudo[22230]: pam_unix(sudo:session): session closed for user root Apr 16 20:29:41 lp mpd[22232]: Apr 16 20:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 16 20:29:41 lp systemd[1]: Started Music Player Daemon. Apr 16 20:29:41 lp sudo[22222]: pam_unix(sudo:session): session closed for user root Apr 16 20:29:41 lp volumio[1164]: error: updateQueue error: null Apr 16 20:30:02 lp volumio[1164]: error: Upnp client error: Error: This socket has been ended by the other party Apr 16 20:30:04 lp volumio[1164]: info: Clearing queue after UPNP request Apr 16 20:30:04 lp volumio[1164]: info: CoreStateMachine::ClearQueue Apr 16 20:30:04 lp volumio[1164]: info: CoreStateMachine::stop Apr 16 20:30:04 lp volumio[1164]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 20:30:04 lp volumio[1164]: info: CoreStateMachine::stPlaybackTimer Apr 16 20:30:04 lp volumio[1164]: info: CoreStateMachine::updateTrackBlock Apr 16 20:30:04 lp volumio[1164]: info: CorePlayQueue::getTrackBlock Apr 16 20:30:04 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:30:04 lp volumio[1164]: info: CorePlayQueue::getTrack 0 Apr 16 20:30:04 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 20:30:04 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:04 lp volumio[1164]: info: CoreStateMachine::serviceStop Apr 16 20:30:04 lp volumio[1164]: info: CorePlayQueue::getTrack 0 Apr 16 20:30:04 lp volumio[1164]: info: ControllerMpd::stop Apr 16 20:30:04 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 20:30:04 lp volumio[1164]: info: CorePlayQueue::clearPlayQueue Apr 16 20:30:04 lp volumio[1164]: info: CorePlayQueue::saveQueue Apr 16 20:30:04 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:04 lp volumio[1164]: info: CoreCommandRouter::volumioPushQueue Apr 16 20:30:04 lp volumio[1164]: info: Apr 16 20:30:04 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:04 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:04 lp volumio[1164]: info: sendMpdCommand stop took 28 milliseconds Apr 16 20:30:04 lp volumio[1164]: error: updateQueue error: null Apr 16 20:30:04 lp volumio[1164]: info: ------------------------------ 5ms Apr 16 20:30:04 lp volumio[1164]: info: Starting UPNP Playback Apr 16 20:30:04 lp volumio[1164]: info: Preparing playback through UPNP Apr 16 20:30:04 lp volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 16 20:30:04 lp volumio[1164]: info: CorePlayQueue::getTrack 0 Apr 16 20:30:04 lp volumio[1164]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 16 20:30:05 lp volumio[1164]: info: Apr 16 20:30:05 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:05 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:05 lp volumio[1164]: info: Apr 16 20:30:05 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:05 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:05 lp volumio[1164]: info: ------------------------------ 11ms Apr 16 20:30:05 lp volumio[1164]: info: ------------------------------ 4ms Apr 16 20:30:05 lp volumio[1164]: info: Apr 16 20:30:05 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:05 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:05 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:30:05 lp volumio[1164]: info: Apr 16 20:30:05 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:05 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:05 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:30:05 lp volumio[1164]: info: Apr 16 20:30:05 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:05 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:05 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:30:05 lp volumio[1164]: info: Apr 16 20:30:05 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:05 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:05 lp volumio[1164]: info: ------------------------------ 2ms Apr 16 20:30:06 lp volumio[1164]: info: Apr 16 20:30:06 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:30:06 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:30:06 lp volumio[1164]: info: Apr 16 20:30:06 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:06 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:06 lp volumio[1164]: info: Apr 16 20:30:06 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:30:06 lp volumio[1164]: info: sendMpdCommand status took 33 milliseconds Apr 16 20:30:06 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:30:06 lp volumio[1164]: info: ------------------------------ 22ms Apr 16 20:30:06 lp volumio[1164]: info: sendMpdCommand status took 12 milliseconds Apr 16 20:30:06 lp volumio[1164]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:30:06 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:30:06 lp volumio[1164]: verbose: In UPNP mode Apr 16 20:30:06 lp volumio[1164]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"葬花吟","artist":"童丽","album":"对话Ⅶ-古筝与童丽的故事","uri":"http://aqqmusic.tc.qq.com/F0000004Gi6j1D3pYs.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=7F5F26918F7EDACCBE6DA786BD811B2240DA1ADBD1C4B003229B63D550B6F350461750D709C2E41BF04394671C6E80986D5C09ABA06180DC__v21e2a1873&uin=1152921504891883214&redirect=1&fromtag=111114","trackType":""} Apr 16 20:30:06 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::syncState stateService play Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus stop Apr 16 20:30:06 lp volumio[1164]: info: ------------------------------ 56ms Apr 16 20:30:06 lp volumio[1164]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:30:06 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:30:06 lp volumio[1164]: verbose: In UPNP mode Apr 16 20:30:06 lp volumio[1164]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"592 Kbps","isStreaming":false,"title":"葬花吟","artist":"童丽","album":"对话Ⅶ-古筝与童丽的故事","uri":"http://aqqmusic.tc.qq.com/F0000004Gi6j1D3pYs.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=7F5F26918F7EDACCBE6DA786BD811B2240DA1ADBD1C4B003229B63D550B6F350461750D709C2E41BF04394671C6E80986D5C09ABA06180DC__v21e2a1873&uin=1152921504891883214&redirect=1&fromtag=111114","trackType":""} Apr 16 20:30:06 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::syncState stateService play Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus play Apr 16 20:30:06 lp volumio[1164]: info: Received an update from plugin. extracting info from payload Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:06 lp volumio[1164]: info: ------------------------------ 62ms Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:30:06 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:30:06 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:30:06 lp volumio[1164]: info: Apr 16 20:30:06 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:30:06 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:30:06 lp volumio[1164]: info: sendMpdCommand status took 1 milliseconds Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:30:06 lp volumio[1164]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 16 20:30:06 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:30:06 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:06 lp volumio[1164]: info: CorePlayQueue::getTrack 0 Apr 16 20:30:06 lp volumio[1164]: 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://aqqmusic.tc.qq.com/F0000004Gi6j1D3pYs.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=7F5F26918F7EDACCBE6DA786BD811B2240DA1ADBD1C4B003229B63D550B6F350461750D709C2E41BF04394671C6E80986D5C09ABA06180DC__v21e2a1873&uin=1152921504891883214&redirect=1&fromtag=111114","trackType":""} Apr 16 20:30:06 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::syncState stateService stop Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus play Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::stPlaybackTimer Apr 16 20:30:06 lp volumio[1164]: info: ------------------------------ 21ms Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:30:06 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:30:06 lp volumio[1164]: info: Clearing queue after UPNP request Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::ClearQueue Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::stop Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 20:30:06 lp volumio[1164]: info: CorePlayQueue::clearPlayQueue Apr 16 20:30:06 lp volumio[1164]: info: CorePlayQueue::saveQueue Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioPushQueue Apr 16 20:30:06 lp volumio[1164]: info: Apr 16 20:30:06 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:06 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:06 lp volumio[1164]: error: updateQueue error: null Apr 16 20:30:06 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:30:06 lp volumio[1164]: info: Starting UPNP Playback Apr 16 20:30:06 lp volumio[1164]: info: Preparing playback through UPNP Apr 16 20:30:06 lp volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 16 20:30:06 lp volumio[1164]: info: CorePlayQueue::getTrack 0 Apr 16 20:30:06 lp volumio[1164]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:07 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:07 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 5ms Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:07 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 4ms Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:07 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 2ms Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:07 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:07 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 3ms Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:30:07 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:30:07 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:30:07 lp volumio[1164]: info: sendMpdCommand status took 24 milliseconds Apr 16 20:30:07 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:30:07 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces system playlist update Apr 16 20:30:07 lp volumio[1164]: info: Ignoring MPD Status Update Apr 16 20:30:07 lp volumio[1164]: info: Apr 16 20:30:07 lp volumio[1164]: ---------------------------- MPD announces state update: player Apr 16 20:30:07 lp volumio[1164]: info: ControllerMpd::getState Apr 16 20:30:07 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand status Apr 16 20:30:07 lp volumio[1164]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 16 20:30:07 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:30:07 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:30:07 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:30:07 lp volumio[1164]: verbose: In UPNP mode Apr 16 20:30:07 lp volumio[1164]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"约定","artist":"童丽","album":"每一个晚上","uri":"http://aqqmusic.tc.qq.com/F000003SYpJ70Bg0GJ.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=0847707FDE87CCF611F26D63771A5D02A21BF1A04CB4B5ABD4427210AC5EB43D4D0977EE8F4150C957FC85CA0533CE671C63B324A0C6C0E6__v2b9ab34b&uin=1152921504891883214&src=F000004f1P5j3W9YEP.flac&redirect=1&fromtag=111114","trackType":""} Apr 16 20:30:07 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:30:07 lp volumio[1164]: info: CoreStateMachine::syncState stateService play Apr 16 20:30:07 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus stop Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 37ms Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 9ms Apr 16 20:30:07 lp volumio[1164]: info: sendMpdCommand status took 8 milliseconds Apr 16 20:30:07 lp volumio[1164]: verbose: ControllerMpd::parseState Apr 16 20:30:07 lp volumio[1164]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 20:30:07 lp volumio[1164]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 16 20:30:07 lp volumio[1164]: verbose: ControllerMpd::parseTrackInfo Apr 16 20:30:07 lp volumio[1164]: info: ControllerMpd::pushState Apr 16 20:30:07 lp volumio[1164]: info: CoreCommandRouter::servicePushState Apr 16 20:30:07 lp volumio[1164]: verbose: In UPNP mode Apr 16 20:30:07 lp volumio[1164]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"约定","artist":"童丽","album":"每一个晚上","uri":"http://aqqmusic.tc.qq.com/F000003SYpJ70Bg0GJ.flac?guid=ffffffff91843f3400000194a033c7b7&vkey=0847707FDE87CCF611F26D63771A5D02A21BF1A04CB4B5ABD4427210AC5EB43D4D0977EE8F4150C957FC85CA0533CE671C63B324A0C6C0E6__v2b9ab34b&uin=1152921504891883214&src=F000004f1P5j3W9YEP.flac&redirect=1&fromtag=111114","trackType":""} Apr 16 20:30:07 lp volumio[1164]: verbose: CURRENT POSITION 0 Apr 16 20:30:07 lp volumio[1164]: info: CoreStateMachine::syncState stateService play Apr 16 20:30:07 lp volumio[1164]: info: CoreStateMachine::syncState currentStatus play Apr 16 20:30:07 lp volumio[1164]: info: Received an update from plugin. extracting info from payload Apr 16 20:30:07 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 16 20:30:07 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:30:07 lp volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 20:30:07 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:07 lp volumio[1164]: info: CoreStateMachine::pushState Apr 16 20:30:07 lp volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 16 20:30:07 lp volumio[1164]: info: ------------------------------ 42ms Apr 16 20:30:07 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:30:07 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:30:07 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:30:07 lp volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 16 20:30:07 lp volumio[1164]: info: CoreStateMachine::getQueue Apr 16 20:30:07 lp volumio[1164]: info: CorePlayQueue::getQueue Apr 16 20:30:10 lp volumio[1164]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%AB%A5%E4%B8%BD/%E6%AF%8F%E4%B8%80%E4%B8%AA%E6%99%9A%E4%B8%8A/435fd5eb-e435-4025-a821-3b4b3a49fe81.jpg' Apr 16 20:30:52 lp volumio[1164]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 20:30:52 lp volumio[1164]: Error: connect ETIMEDOUT 154.85.102.32:443 Apr 16 20:30:52 lp volumio[1164]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 16 20:30:52 lp volumio[1164]: errno: -110, Apr 16 20:30:52 lp volumio[1164]: code: 'ETIMEDOUT', Apr 16 20:30:52 lp volumio[1164]: syscall: 'connect', Apr 16 20:30:52 lp volumio[1164]: address: '154.85.102.32', Apr 16 20:30:52 lp volumio[1164]: port: 443 Apr 16 20:30:52 lp volumio[1164]: } Apr 16 20:30:52 lp volumio[1164]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 20:30:53 lp sudo[22694]: volumio : unable to resolve host lp Apr 16 20:30:53 lp sudo[22694]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 16 20:30:53 lp sudo[22694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-16 20:29 Apr 16 20:30:53 lp sudo[22694]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"