-- Logs begin at Sat 2024-04-20 07:01:37 UTC, end at Sun 2024-04-21 12:45:23 UTC. -- Apr 21 12:44:05 musical-fidelity volumio[12398]: info: Apr 21 12:44:05 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:05 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:05 musical-fidelity volumio[12398]: info: sendMpdCommand status took 3 milliseconds Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:05 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:05 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:05 musical-fidelity volumio[12398]: 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":"New Jeans","artist":"NewJeans","album":"NewJeans 'Super Shy'","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800001QG6Rf3o63hU.mp3?guid=00000000411549570000018c24bfe7bf&vkey=84C2F5781DE44F02EEB71983837023FCF3E0EF9B0E3CF46B204385A656A56352D467E8C470D6A2AC53F4D7DEA69B4EEEE5BE1E6A46DC3EAF&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService stop Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::play index undefined Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:05 musical-fidelity volumio[12398]: info: ------------------------------ 29ms Apr 21 12:44:05 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:05 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:05 musical-fidelity volumio[12398]: info: Clearing queue after UPNP request Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::ClearQueue Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::stop Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: UNSET VOLATILE Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CorePlayQueue::clearPlayQueue Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CorePlayQueue::saveQueue Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushQueue Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:06 musical-fidelity volumio[12398]: error: updateQueue error: null Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Starting UPNP Playback Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Preparing playback through UPNP Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioGetState Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 3ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 3ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:06 musical-fidelity volumio[12398]: info: sendMpdCommand status took 8 milliseconds Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:06 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: In UPNP mode Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"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://117.34.49.49/amobile.music.tc.qq.com/M800002rkevY0Wf4ob.mp3?guid=00000000411549570000018c24bfe7bf&vkey=845B9B34B201C6EBC7543320A53220BA12CC1B35196A37C047E8E511BCA6891D13B5522E389EE4A8C78192B22A24721E4D2C869A2B0BEEDD&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus stop Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 28ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 20ms Apr 21 12:44:06 musical-fidelity volumio[12398]: info: sendMpdCommand status took 18 milliseconds Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:07 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: In UPNP mode Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":333,"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://117.34.49.49/amobile.music.tc.qq.com/M800002rkevY0Wf4ob.mp3?guid=00000000411549570000018c24bfe7bf&vkey=845B9B34B201C6EBC7543320A53220BA12CC1B35196A37C047E8E511BCA6891D13B5522E389EE4A8C78192B22A24721E4D2C869A2B0BEEDD&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Received an update from plugin. extracting info from payload Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ------------------------------ 66ms Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:07 musical-fidelity volumio[12398]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/NewJeans/NewJeans%20%27Super%20Shy%27/5b9ba58a-d02e-4bda-88ae-9c82311efb42.jpg' Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Apr 21 12:44:07 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:07 musical-fidelity volumio[12398]: info: sendMpdCommand status took 3 milliseconds Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:07 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:07 musical-fidelity volumio[12398]: 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://117.34.49.49/amobile.music.tc.qq.com/M800002rkevY0Wf4ob.mp3?guid=00000000411549570000018c24bfe7bf&vkey=845B9B34B201C6EBC7543320A53220BA12CC1B35196A37C047E8E511BCA6891D13B5522E389EE4A8C78192B22A24721E4D2C869A2B0BEEDD&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService stop Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::play index undefined Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ------------------------------ 26ms Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Clearing queue after UPNP request Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::ClearQueue Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::stop Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: UNSET VOLATILE Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::clearPlayQueue Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::saveQueue Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushQueue Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Apr 21 12:44:07 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:07 musical-fidelity volumio[12398]: error: updateQueue error: null Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Starting UPNP Playback Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Preparing playback through UPNP Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioGetState Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 3ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand status took 10 milliseconds Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 14ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand status took 12 milliseconds Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: In UPNP mode Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":109,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"New Jeans","artist":"NewJeans","album":"NewJeans 'Super Shy'","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800001QG6Rf3o63hU.mp3?guid=00000000411549570000018c24bfe7bf&vkey=84C2F5781DE44F02EEB71983837023FCF3E0EF9B0E3CF46B204385A656A56352D467E8C470D6A2AC53F4D7DEA69B4EEEE5BE1E6A46DC3EAF&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus stop Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 62ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: In UPNP mode Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":109,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"New Jeans","artist":"NewJeans","album":"NewJeans 'Super Shy'","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800001QG6Rf3o63hU.mp3?guid=00000000411549570000018c24bfe7bf&vkey=84C2F5781DE44F02EEB71983837023FCF3E0EF9B0E3CF46B204385A656A56352D467E8C470D6A2AC53F4D7DEA69B4EEEE5BE1E6A46DC3EAF&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Received an update from plugin. extracting info from payload Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 85ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand status took 5 milliseconds Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:08 musical-fidelity volumio[12398]: 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":"New Jeans","artist":"NewJeans","album":"NewJeans 'Super Shy'","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800001QG6Rf3o63hU.mp3?guid=00000000411549570000018c24bfe7bf&vkey=84C2F5781DE44F02EEB71983837023FCF3E0EF9B0E3CF46B204385A656A56352D467E8C470D6A2AC53F4D7DEA69B4EEEE5BE1E6A46DC3EAF&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService stop Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::play index undefined Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 53ms Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:08 musical-fidelity volumio[12398]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/NewJeans/NewJeans%20%27Super%20Shy%27/5b9ba58a-d02e-4bda-88ae-9c82311efb42.jpg' Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Clearing queue after UPNP request Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::ClearQueue Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::stop Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: UNSET VOLATILE Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::clearPlayQueue Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::saveQueue Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushQueue Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Starting UPNP Playback Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Preparing playback through UPNP Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioGetState Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 12:44:09 musical-fidelity volumio[12398]: error: updateQueue error: null Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 4ms Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 3ms Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 3ms Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:09 musical-fidelity volumio[12398]: info: sendMpdCommand status took 11 milliseconds Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:09 musical-fidelity volumio[12398]: info: sendMpdCommand status took 5 milliseconds Apr 21 12:44:09 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 4ms Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: In UPNP mode Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"TOP","artist":"Stray Kids","album":"TOP","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M80000233xML43Ubsa.mp3?guid=00000000411549570000018c24bfe7bf&vkey=977E55760F55E74BEFA01015D26AEACE6AB6C83EE22E94C82119B35EB7D0E7DFCC10EC1A5A9807E0C0540956ABD3CCCF5743D766D6E59338&uin=2855958070&src=M800000mM5rr4QiAwS.mp3&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus stop Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:10 musical-fidelity volumio[12398]: info: ------------------------------ 38ms Apr 21 12:44:10 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 21 12:44:10 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:10 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:10 musical-fidelity volumio[12398]: verbose: In UPNP mode Apr 21 12:44:10 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"TOP","artist":"Stray Kids","album":"TOP","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M80000233xML43Ubsa.mp3?guid=00000000411549570000018c24bfe7bf&vkey=977E55760F55E74BEFA01015D26AEACE6AB6C83EE22E94C82119B35EB7D0E7DFCC10EC1A5A9807E0C0540956ABD3CCCF5743D766D6E59338&uin=2855958070&src=M800000mM5rr4QiAwS.mp3&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:10 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play Apr 21 12:44:10 musical-fidelity volumio[12398]: info: Received an update from plugin. extracting info from payload Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:10 musical-fidelity volumio[12398]: info: ------------------------------ 65ms Apr 21 12:44:10 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:10 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:10 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:10 musical-fidelity volumio[12398]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/NewJeans/NewJeans%20%27Super%20Shy%27/5b9ba58a-d02e-4bda-88ae-9c82311efb42.jpg' Apr 21 12:44:31 musical-fidelity volumio[12398]: info: Apr 21 12:44:31 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:31 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:31 musical-fidelity volumio[12398]: info: sendMpdCommand status took 1 milliseconds Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:31 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:31 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:31 musical-fidelity volumio[12398]: 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":"TOP","artist":"Stray Kids","album":"TOP","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M80000233xML43Ubsa.mp3?guid=00000000411549570000018c24bfe7bf&vkey=977E55760F55E74BEFA01015D26AEACE6AB6C83EE22E94C82119B35EB7D0E7DFCC10EC1A5A9807E0C0540956ABD3CCCF5743D766D6E59338&uin=2855958070&src=M800000mM5rr4QiAwS.mp3&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService stop Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::play index undefined Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:31 musical-fidelity volumio[12398]: info: ------------------------------ 31ms Apr 21 12:44:31 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:31 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:31 musical-fidelity volumio[12398]: info: Clearing queue after UPNP request Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::ClearQueue Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::stop Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: UNSET VOLATILE Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CorePlayQueue::clearPlayQueue Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CorePlayQueue::saveQueue Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushQueue Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:32 musical-fidelity volumio[12398]: error: updateQueue error: null Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 3ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Starting UPNP Playback Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Preparing playback through UPNP Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioGetState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0 Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 3ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 3ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 4ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 4ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 4ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 2ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player Apr 21 12:44:32 musical-fidelity volumio[12398]: info: sendMpdCommand status took 19 milliseconds Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ControllerMpd::getState Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update Apr 21 12:44:32 musical-fidelity volumio[12398]: info: sendMpdCommand status took 5 milliseconds Apr 21 12:44:32 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: In UPNP mode Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":167,"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://117.34.49.49/amobile.music.tc.qq.com/M8000030i9qm32V1qd.mp3?guid=00000000411549570000018c24bfe7bf&vkey=4B22306105CBF3AB74A0963D7AAE12A87670ED03788A075FA81C8E2BEAF08873BA08FBF8CB0B2CD7D9A954F9A5266338888094574BCCA8C2&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus stop Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 42ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 21ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ControllerMpd::pushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: In UPNP mode Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":167,"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://117.34.49.49/amobile.music.tc.qq.com/M8000030i9qm32V1qd.mp3?guid=00000000411549570000018c24bfe7bf&vkey=4B22306105CBF3AB74A0963D7AAE12A87670ED03788A075FA81C8E2BEAF08873BA08FBF8CB0B2CD7D9A954F9A5266338888094574BCCA8C2&uin=2855958070&redirect=1&fromtag=111093","trackType":""} Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0 Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Received an update from plugin. extracting info from payload Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 66ms Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path Apr 21 12:44:33 musical-fidelity volumio[12398]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Stray%20Kids/TOP/12978877-8957-4d96-88d3-9d0dedd4ba5b.jpg' Apr 21 12:45:22 musical-fidelity volumio[12398]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 12:45:22 musical-fidelity volumio[12398]: { Error: connect ETIMEDOUT 128.242.240.221:443 Apr 21 12:45:22 musical-fidelity volumio[12398]: at Object._errnoException (util.js:1022:11) Apr 21 12:45:22 musical-fidelity volumio[12398]: at _exceptionWithHostPort (util.js:1044:20) Apr 21 12:45:22 musical-fidelity volumio[12398]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 21 12:45:22 musical-fidelity volumio[12398]: code: 'ETIMEDOUT', Apr 21 12:45:22 musical-fidelity volumio[12398]: errno: 'ETIMEDOUT', Apr 21 12:45:22 musical-fidelity volumio[12398]: syscall: 'connect', Apr 21 12:45:22 musical-fidelity volumio[12398]: address: '128.242.240.221', Apr 21 12:45:22 musical-fidelity volumio[12398]: port: 443 } Apr 21 12:45:22 musical-fidelity volumio[12398]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 12:45:23 musical-fidelity sudo[15009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 12:44 Apr 21 12:45:23 musical-fidelity sudo[15009]: 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="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"