-- Logs begin at Sat 2025-03-15 20:58:23 CST, end at Sat 2025-03-15 21:02:15 CST. -- Mar 15 21:01:02 volumio volumio[719]: info: CoreCommandRouter::volumioGetState Mar 15 21:01:02 volumio volumio[719]: info: CorePlayQueue::getTrack 0 Mar 15 21:01:03 volumio volumio[719]: info: Clearing queue after UPNP request Mar 15 21:01:04 volumio volumio[719]: info: CoreStateMachine::ClearQueue Mar 15 21:01:04 volumio volumio[719]: info: CoreStateMachine::stop Mar 15 21:01:04 volumio volumio[719]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 15 21:01:04 volumio volumio[719]: info: CorePlayQueue::clearPlayQueue Mar 15 21:01:04 volumio volumio[719]: info: CorePlayQueue::saveQueue Mar 15 21:01:04 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:04 volumio volumio[719]: info: CoreCommandRouter::volumioPushQueue Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: error: updateQueue error: null Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 3ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 2ms Mar 15 21:01:04 volumio volumio[719]: info: Starting UPNP Playback Mar 15 21:01:04 volumio volumio[719]: info: Preparing playback through UPNP Mar 15 21:01:04 volumio volumio[719]: info: CoreCommandRouter::volumioGetState Mar 15 21:01:04 volumio volumio[719]: info: CorePlayQueue::getTrack 0 Mar 15 21:01:04 volumio volumio[719]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 3ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 2ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 1ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 2ms Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 3ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 2ms Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 3ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 2ms Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 5ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 5ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 4ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 4ms Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 3ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 3ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 2ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 2ms Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: Mar 15 21:01:04 volumio volumio[719]: ---------------------------- MPD announces system playlist update Mar 15 21:01:04 volumio volumio[719]: info: Ignoring MPD Status Update Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 4ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 4ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 2ms Mar 15 21:01:04 volumio volumio[719]: info: ------------------------------ 1ms Mar 15 21:01:05 volumio volumio[719]: info: Mar 15 21:01:05 volumio volumio[719]: ---------------------------- MPD announces state update: player Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::getState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:01:05 volumio volumio[719]: info: Mar 15 21:01:05 volumio volumio[719]: ---------------------------- MPD announces state update: player Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::getState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:01:05 volumio volumio[719]: info: Mar 15 21:01:05 volumio volumio[719]: ---------------------------- MPD announces state update: player Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::getState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:01:05 volumio volumio[719]: info: Mar 15 21:01:05 volumio volumio[719]: ---------------------------- MPD announces state update: player Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::getState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:01:05 volumio volumio[719]: info: Mar 15 21:01:05 volumio volumio[719]: ---------------------------- MPD announces state update: player Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::getState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:01:05 volumio volumio[719]: info: Mar 15 21:01:05 volumio volumio[719]: ---------------------------- MPD announces state update: player Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::getState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:01:05 volumio volumio[719]: info: Mar 15 21:01:05 volumio volumio[719]: ---------------------------- MPD announces state update: player Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::getState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:01:05 volumio volumio[719]: info: Mar 15 21:01:05 volumio volumio[719]: ---------------------------- MPD announces state update: player Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand status took 16 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand status took 15 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::getState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand status took 13 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand status took 12 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand status took 5 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand status took 4 milliseconds Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand status took 7 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand status took 5 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseState Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::servicePushState Mar 15 21:01:05 volumio volumio[719]: verbose: In UPNP mode Mar 15 21:01:05 volumio volumio[719]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"问","artist":"林忆莲","album":"回忆莲莲","uri":"http://m8.music.126.net/20250315212603/620adefe579d75fda6182fdd9f410c3c/ymusic/5458/055c/0f09/c236c521b026bd7462648cc89cfbff56.mp3?vuutv=hty4gaZ3inM7lOowWY8TxCTcXd5iter5I+3P4ET/JpGfvy1cuN9ZyAWBDF/S3wgi40YxgDZQQmMRWgVlZ2SabQperxRAap5LHUCRQcltbw4=","trackType":""} Mar 15 21:01:05 volumio volumio[719]: verbose: CURRENT POSITION 0 Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState stateService play Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState currentStatus stop Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::servicePushState Mar 15 21:01:05 volumio volumio[719]: verbose: In UPNP mode Mar 15 21:01:05 volumio volumio[719]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"问","artist":"林忆莲","album":"回忆莲莲","uri":"http://m8.music.126.net/20250315212603/620adefe579d75fda6182fdd9f410c3c/ymusic/5458/055c/0f09/c236c521b026bd7462648cc89cfbff56.mp3?vuutv=hty4gaZ3inM7lOowWY8TxCTcXd5iter5I+3P4ET/JpGfvy1cuN9ZyAWBDF/S3wgi40YxgDZQQmMRWgVlZ2SabQperxRAap5LHUCRQcltbw4=","trackType":""} Mar 15 21:01:05 volumio volumio[719]: verbose: CURRENT POSITION 0 Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState stateService play Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:01:05 volumio volumio[719]: info: Received an update from plugin. extracting info from payload Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::servicePushState Mar 15 21:01:05 volumio volumio[719]: verbose: In UPNP mode Mar 15 21:01:05 volumio volumio[719]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"问","artist":"林忆莲","album":"回忆莲莲","uri":"http://m8.music.126.net/20250315212603/620adefe579d75fda6182fdd9f410c3c/ymusic/5458/055c/0f09/c236c521b026bd7462648cc89cfbff56.mp3?vuutv=hty4gaZ3inM7lOowWY8TxCTcXd5iter5I+3P4ET/JpGfvy1cuN9ZyAWBDF/S3wgi40YxgDZQQmMRWgVlZ2SabQperxRAap5LHUCRQcltbw4=","trackType":""} Mar 15 21:01:05 volumio volumio[719]: verbose: CURRENT POSITION 0 Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState stateService play Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:01:05 volumio volumio[719]: info: Received an update from plugin. extracting info from payload Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::servicePushState Mar 15 21:01:05 volumio volumio[719]: verbose: In UPNP mode Mar 15 21:01:05 volumio volumio[719]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"问","artist":"林忆莲","album":"回忆莲莲","uri":"http://m8.music.126.net/20250315212603/620adefe579d75fda6182fdd9f410c3c/ymusic/5458/055c/0f09/c236c521b026bd7462648cc89cfbff56.mp3?vuutv=hty4gaZ3inM7lOowWY8TxCTcXd5iter5I+3P4ET/JpGfvy1cuN9ZyAWBDF/S3wgi40YxgDZQQmMRWgVlZ2SabQperxRAap5LHUCRQcltbw4=","trackType":""} Mar 15 21:01:05 volumio volumio[719]: verbose: CURRENT POSITION 0 Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState stateService play Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:01:05 volumio volumio[719]: info: Received an update from plugin. extracting info from payload Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::servicePushState Mar 15 21:01:05 volumio volumio[719]: verbose: In UPNP mode Mar 15 21:01:05 volumio volumio[719]: verbose: STATE SERVICE {"status":"play","position":0,"seek":352,"duration":228,"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://m8.music.126.net/20250315212603/620adefe579d75fda6182fdd9f410c3c/ymusic/5458/055c/0f09/c236c521b026bd7462648cc89cfbff56.mp3?vuutv=hty4gaZ3inM7lOowWY8TxCTcXd5iter5I+3P4ET/JpGfvy1cuN9ZyAWBDF/S3wgi40YxgDZQQmMRWgVlZ2SabQperxRAap5LHUCRQcltbw4=","trackType":""} Mar 15 21:01:05 volumio volumio[719]: verbose: CURRENT POSITION 0 Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState stateService play Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:01:05 volumio volumio[719]: info: Received an update from plugin. extracting info from payload Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::servicePushState Mar 15 21:01:05 volumio volumio[719]: verbose: In UPNP mode Mar 15 21:01:05 volumio volumio[719]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":228,"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://m8.music.126.net/20250315212603/620adefe579d75fda6182fdd9f410c3c/ymusic/5458/055c/0f09/c236c521b026bd7462648cc89cfbff56.mp3?vuutv=hty4gaZ3inM7lOowWY8TxCTcXd5iter5I+3P4ET/JpGfvy1cuN9ZyAWBDF/S3wgi40YxgDZQQmMRWgVlZ2SabQperxRAap5LHUCRQcltbw4=","trackType":""} Mar 15 21:01:05 volumio volumio[719]: verbose: CURRENT POSITION 0 Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState stateService play Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:01:05 volumio volumio[719]: info: Received an update from plugin. extracting info from payload Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: ------------------------------ 53ms Mar 15 21:01:05 volumio volumio[719]: info: ------------------------------ 103ms Mar 15 21:01:05 volumio volumio[719]: info: ------------------------------ 102ms Mar 15 21:01:05 volumio volumio[719]: info: ------------------------------ 100ms Mar 15 21:01:05 volumio volumio[719]: info: ------------------------------ 95ms Mar 15 21:01:05 volumio volumio[719]: info: ------------------------------ 94ms Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand playlistinfo took 84 milliseconds Mar 15 21:01:05 volumio volumio[719]: info: sendMpdCommand playlistinfo took 84 milliseconds Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:01:05 volumio volumio[719]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::servicePushState Mar 15 21:01:05 volumio volumio[719]: verbose: In UPNP mode Mar 15 21:01:05 volumio volumio[719]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":228,"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://m8.music.126.net/20250315212603/620adefe579d75fda6182fdd9f410c3c/ymusic/5458/055c/0f09/c236c521b026bd7462648cc89cfbff56.mp3?vuutv=hty4gaZ3inM7lOowWY8TxCTcXd5iter5I+3P4ET/JpGfvy1cuN9ZyAWBDF/S3wgi40YxgDZQQmMRWgVlZ2SabQperxRAap5LHUCRQcltbw4=","trackType":""} Mar 15 21:01:05 volumio volumio[719]: verbose: CURRENT POSITION 0 Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState stateService play Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:01:05 volumio volumio[719]: info: Received an update from plugin. extracting info from payload Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: ControllerMpd::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::servicePushState Mar 15 21:01:05 volumio volumio[719]: verbose: In UPNP mode Mar 15 21:01:05 volumio volumio[719]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":228,"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://m8.music.126.net/20250315212603/620adefe579d75fda6182fdd9f410c3c/ymusic/5458/055c/0f09/c236c521b026bd7462648cc89cfbff56.mp3?vuutv=hty4gaZ3inM7lOowWY8TxCTcXd5iter5I+3P4ET/JpGfvy1cuN9ZyAWBDF/S3wgi40YxgDZQQmMRWgVlZ2SabQperxRAap5LHUCRQcltbw4=","trackType":""} Mar 15 21:01:05 volumio volumio[719]: verbose: CURRENT POSITION 0 Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState stateService play Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:01:05 volumio volumio[719]: info: Received an update from plugin. extracting info from payload Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::pushState Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioPushState Mar 15 21:01:05 volumio volumio[719]: info: ------------------------------ 133ms Mar 15 21:01:05 volumio volumio[719]: info: ------------------------------ 132ms Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:01:05 volumio volumio[719]: info: CoreStateMachine::getQueue Mar 15 21:01:05 volumio volumio[719]: info: CorePlayQueue::getQueue Mar 15 21:01:13 volumio volumio[719]: info: CoreCommandRouter::volumioGetState Mar 15 21:01:13 volumio sudo[2452]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Mar 15 21:01:13 volumio sudo[2452]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 21:01:15 volumio volumio[719]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 7 Mar 15 21:01:16 volumio volumio[719]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 8 Mar 15 21:01:16 volumio volumio[719]: info: CoreCommandRouter::volumioGetState Mar 15 21:01:31 volumio volumio[719]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 9 Mar 15 21:01:32 volumio volumio[719]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 10 Mar 15 21:01:32 volumio volumio[719]: info: CoreCommandRouter::volumioGetState Mar 15 21:01:48 volumio volumio[719]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 11 Mar 15 21:01:49 volumio volumio[719]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 12 Mar 15 21:01:49 volumio volumio[719]: info: CoreCommandRouter::volumioGetState Mar 15 21:02:05 volumio volumio[719]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 13 Mar 15 21:02:06 volumio volumio[719]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 12 Mar 15 21:02:06 volumio volumio[719]: info: CoreCommandRouter::volumioGetState Mar 15 21:02:15 volumio volumio[719]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 21:02:15 volumio volumio[719]: Error: connect ETIMEDOUT 157.240.18.18:443 Mar 15 21:02:15 volumio volumio[719]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 15 21:02:15 volumio volumio[719]: errno: -110, Mar 15 21:02:15 volumio volumio[719]: code: 'ETIMEDOUT', Mar 15 21:02:15 volumio volumio[719]: syscall: 'connect', Mar 15 21:02:15 volumio volumio[719]: address: '157.240.18.18', Mar 15 21:02:15 volumio volumio[719]: port: 443 Mar 15 21:02:15 volumio volumio[719]: } Mar 15 21:02:15 volumio volumio[719]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 21:02:15 volumio sudo[2756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-15 21:01 Mar 15 21:02:15 volumio sudo[2756]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"