-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-07-14 12:04:48 CEST. -- Jul 14 12:03:04 volumiopi3 volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 3 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Prefetching next song Jul 14 12:03:22 volumiopi3 volumio[1067]: info: [ytmusic] Preferred format is Opus Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-w511uxa-h5qd.googlevideo.com/videoplayback?expire=1720973002&ei=aqKTZuLSCvmahcIPgJKlaA&ip=90.171.233.248&id=o-AFsq6joFWLbERkW4ZJIZkIIhqkgRcuG3XI_TtVLZDCfz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=kR&mm=31%2C26&mn=sn-w511uxa-h5qd%2Csn-5hne6n6l&ms=au%2Conr&mv=m&mvi=3&pcm2cms=yes&pl=21&gcr=es&initcwndbps=2668750&bui=AXc671JI_mzee2vXPY65LJ_ia2MxybPjcWbHjRJHyXxafSiPF4B0twiTJXIxKDFbim1JvLZYv7GraS7G&spc=NO7bAa6-d1SRIb1_7DbUnzKRKxOWw8jKRohPHY0-nDruNuVW2g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=xz8gmRGBdnQaM7EFj8fT-n8Q&rqh=1&gir=yes&clen=3499238&dur=205.381&lmt=1714879641827443&mt=1720951025&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=oM1Lw4ta8-Q8bg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRQIgLWQqWAz37v_4hYNleTJEr1f0v3v_mqfskU04kCz-R4sCIQCdVuDDHtcBQCaD-aBoca5pQWbMaOMy3qZyT7u4e8if_w%3D%3D&sig=AJfQdSswRAIgFhN7_a7WyhbHFQ21jdWLw0F1ag3n5XPg_8D92MVttzsCIFiNqw4Wkz5rSEsLWTkZaVK_NTGyjpv3y9Qsm9JnRcgf&cver=1.20211213.00.00&t.YouTube" Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand addid "https://rr3---sn-w511uxa-h5qd.googlevideo.com/videoplayback?expire=1720973002&ei=aqKTZuLSCvmahcIPgJKlaA&ip=90.171.233.248&id=o-AFsq6joFWLbERkW4ZJIZkIIhqkgRcuG3XI_TtVLZDCfz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=kR&mm=31%2C26&mn=sn-w511uxa-h5qd%2Csn-5hne6n6l&ms=au%2Conr&mv=m&mvi=3&pcm2cms=yes&pl=21&gcr=es&initcwndbps=2668750&bui=AXc671JI_mzee2vXPY65LJ_ia2MxybPjcWbHjRJHyXxafSiPF4B0twiTJXIxKDFbim1JvLZYv7GraS7G&spc=NO7bAa6-d1SRIb1_7DbUnzKRKxOWw8jKRohPHY0-nDruNuVW2g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=xz8gmRGBdnQaM7EFj8fT-n8Q&rqh=1&gir=yes&clen=3499238&dur=205.381&lmt=1714879641827443&mt=1720951025&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=oM1Lw4ta8-Q8bg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRQIgLWQqWAz37v_4hYNleTJEr1f0v3v_mqfskU04kCz-R4sCIQCdVuDDHtcBQCaD-aBoca5pQWbMaOMy3qZyT7u4e8if_w%3D%3D&sig=AJfQdSswRAIgFhN7_a7WyhbHFQ21jdWLw0F1ag3n5XPg_8D92MVttzsCIFiNqw4Wkz5rSEsLWTkZaVK_NTGyjpv3y9Qsm9JnRcgf&cver=1.20211213.00.00&t.YouTube" took 8 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: MPD COMMAND [object Object] Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: MPD COMMAND [object Object] Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: MPD COMMAND [object Object] Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 20ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 11ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 10ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 8ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: [ytmusic-play] Prefetched and added track to MPD queue: A Dios Le Pido Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces state update: options Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 14ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand consume 1 took 9 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 10ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 9ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 8ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces state update: options Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces state update: options Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Jul 14 12:03:22 volumiopi3 volumio[1067]: ---------------------------- MPD announces state update: options Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand status took 12 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand status took 7 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand status took 6 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand status took 3 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":234865,"duration":238,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fotografía (con Nelly Furtado)","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qk.googlevideo.com/videoplayback?expire=1720972767&ei=f6GTZvPfDs3Op-oPnvu9sAg&ip=90.171.233.248&id=o-ABw0eI0U-3DIFf1d8ze1APsfNKhK1FNUfEwCQR8U24a2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=OL&mm=31%2C26&mn=sn-w511uxa-h5qk%2Csn-5hne6nz6&ms=au%2Conr&mv=m&mvi=3&pl=21&gcr=es&initcwndbps=2423750&bui=AXc671KLTZeEs2fWHgnDvrBq-7NULwkea1R1jKoS1KDovCgePnYiGWko6WFNeZvxJuijf1LLIflK2VdZ&spc=NO7bAQ0R7oK-xaFBH9IunvLibtGPvaZOBTtEXTodLEUN8ZxeLQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=hEFsm8G4DLn16-cwNik1GIMQ&rqh=1&gir=yes&clen=4282844&dur=238.141&lmt=1714856840822822&mt=1720950785&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=zoG72g2V1jCGjw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRAIgKVo3va5ksEC0boSfQs1rJuTI4AVEfavSv-9Lw8iiT6cCICHQCtRpTcUJqDh3kjJLu8gOyn8fCkLmE34ZP3trdmVs&sig=AJfQdSswRgIhANOZCtryQvu59a-xQeoV9j_R6FcgRwQbgW9ayd5kXTUkAiEAvhZeLePYWDuy2BEazecGKeU30Lqrwh6wdCpye1OzuBc%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":234865,"duration":238,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fotografía (con Nelly Furtado)","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qk.googlevideo.com/videoplayback?expire=1720972767&ei=f6GTZvPfDs3Op-oPnvu9sAg&ip=90.171.233.248&id=o-ABw0eI0U-3DIFf1d8ze1APsfNKhK1FNUfEwCQR8U24a2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=OL&mm=31%2C26&mn=sn-w511uxa-h5qk%2Csn-5hne6nz6&ms=au%2Conr&mv=m&mvi=3&pl=21&gcr=es&initcwndbps=2423750&bui=AXc671KLTZeEs2fWHgnDvrBq-7NULwkea1R1jKoS1KDovCgePnYiGWko6WFNeZvxJuijf1LLIflK2VdZ&spc=NO7bAQ0R7oK-xaFBH9IunvLibtGPvaZOBTtEXTodLEUN8ZxeLQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=hEFsm8G4DLn16-cwNik1GIMQ&rqh=1&gir=yes&clen=4282844&dur=238.141&lmt=1714856840822822&mt=1720950785&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=zoG72g2V1jCGjw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRAIgKVo3va5ksEC0boSfQs1rJuTI4AVEfavSv-9Lw8iiT6cCICHQCtRpTcUJqDh3kjJLu8gOyn8fCkLmE34ZP3trdmVs&sig=AJfQdSswRgIhANOZCtryQvu59a-xQeoV9j_R6FcgRwQbgW9ayd5kXTUkAiEAvhZeLePYWDuy2BEazecGKeU30Lqrwh6wdCpye1OzuBc%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":234865,"duration":238,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fotografía (con Nelly Furtado)","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qk.googlevideo.com/videoplayback?expire=1720972767&ei=f6GTZvPfDs3Op-oPnvu9sAg&ip=90.171.233.248&id=o-ABw0eI0U-3DIFf1d8ze1APsfNKhK1FNUfEwCQR8U24a2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=OL&mm=31%2C26&mn=sn-w511uxa-h5qk%2Csn-5hne6nz6&ms=au%2Conr&mv=m&mvi=3&pl=21&gcr=es&initcwndbps=2423750&bui=AXc671KLTZeEs2fWHgnDvrBq-7NULwkea1R1jKoS1KDovCgePnYiGWko6WFNeZvxJuijf1LLIflK2VdZ&spc=NO7bAQ0R7oK-xaFBH9IunvLibtGPvaZOBTtEXTodLEUN8ZxeLQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=hEFsm8G4DLn16-cwNik1GIMQ&rqh=1&gir=yes&clen=4282844&dur=238.141&lmt=1714856840822822&mt=1720950785&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=zoG72g2V1jCGjw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRAIgKVo3va5ksEC0boSfQs1rJuTI4AVEfavSv-9Lw8iiT6cCICHQCtRpTcUJqDh3kjJLu8gOyn8fCkLmE34ZP3trdmVs&sig=AJfQdSswRgIhANOZCtryQvu59a-xQeoV9j_R6FcgRwQbgW9ayd5kXTUkAiEAvhZeLePYWDuy2BEazecGKeU30Lqrwh6wdCpye1OzuBc%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":234865,"duration":238,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fotografía (con Nelly Furtado)","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qk.googlevideo.com/videoplayback?expire=1720972767&ei=f6GTZvPfDs3Op-oPnvu9sAg&ip=90.171.233.248&id=o-ABw0eI0U-3DIFf1d8ze1APsfNKhK1FNUfEwCQR8U24a2&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=OL&mm=31%2C26&mn=sn-w511uxa-h5qk%2Csn-5hne6nz6&ms=au%2Conr&mv=m&mvi=3&pl=21&gcr=es&initcwndbps=2423750&bui=AXc671KLTZeEs2fWHgnDvrBq-7NULwkea1R1jKoS1KDovCgePnYiGWko6WFNeZvxJuijf1LLIflK2VdZ&spc=NO7bAQ0R7oK-xaFBH9IunvLibtGPvaZOBTtEXTodLEUN8ZxeLQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=hEFsm8G4DLn16-cwNik1GIMQ&rqh=1&gir=yes&clen=4282844&dur=238.141&lmt=1714856840822822&mt=1720950785&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=zoG72g2V1jCGjw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRAIgKVo3va5ksEC0boSfQs1rJuTI4AVEfavSv-9Lw8iiT6cCICHQCtRpTcUJqDh3kjJLu8gOyn8fCkLmE34ZP3trdmVs&sig=AJfQdSswRgIhANOZCtryQvu59a-xQeoV9j_R6FcgRwQbgW9ayd5kXTUkAiEAvhZeLePYWDuy2BEazecGKeU30Lqrwh6wdCpye1OzuBc%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:22 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 2 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:22 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 80ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 73ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 71ms Jul 14 12:03:22 volumiopi3 volumio[1067]: info: ------------------------------ 70ms Jul 14 12:03:22 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:22 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:22 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:22 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:22 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:22 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:22 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:22 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:22 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Jul 14 12:03:26 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Jul 14 12:03:26 volumiopi3 volumio[1067]: ---------------------------- MPD announces state update: player Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Jul 14 12:03:26 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Jul 14 12:03:26 volumiopi3 volumio[1067]: ---------------------------- MPD announces state update: player Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Jul 14 12:03:26 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Jul 14 12:03:26 volumiopi3 volumio[1067]: ---------------------------- MPD announces state update: player Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Jul 14 12:03:26 volumiopi3 volumio[1067]: ---------------------------- MPD announces system playlist update Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Ignoring MPD Status Update Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Jul 14 12:03:26 volumiopi3 volumio[1067]: ---------------------------- MPD announces state update: player Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ------------------------------ 16ms Jul 14 12:03:26 volumiopi3 volumio[1067]: info: sendMpdCommand status took 14 milliseconds Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ------------------------------ 14ms Jul 14 12:03:26 volumiopi3 volumio[1067]: info: sendMpdCommand status took 13 milliseconds Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ------------------------------ 12ms Jul 14 12:03:26 volumiopi3 volumio[1067]: info: sendMpdCommand status took 11 milliseconds Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ------------------------------ 10ms Jul 14 12:03:26 volumiopi3 volumio[1067]: info: sendMpdCommand status took 9 milliseconds Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:26 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 14 12:03:26 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 14 12:03:26 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 14 12:03:26 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":95,"duration":205,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A Dios Le Pido","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qd.googlevideo.com/videoplayback?expire=1720973002&ei=aqKTZuLSCvmahcIPgJKlaA&ip=90.171.233.248&id=o-AFsq6joFWLbERkW4ZJIZkIIhqkgRcuG3XI_TtVLZDCfz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=kR&mm=31%2C26&mn=sn-w511uxa-h5qd%2Csn-5hne6n6l&ms=au%2Conr&mv=m&mvi=3&pcm2cms=yes&pl=21&gcr=es&initcwndbps=2668750&bui=AXc671JI_mzee2vXPY65LJ_ia2MxybPjcWbHjRJHyXxafSiPF4B0twiTJXIxKDFbim1JvLZYv7GraS7G&spc=NO7bAa6-d1SRIb1_7DbUnzKRKxOWw8jKRohPHY0-nDruNuVW2g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=xz8gmRGBdnQaM7EFj8fT-n8Q&rqh=1&gir=yes&clen=3499238&dur=205.381&lmt=1714879641827443&mt=1720951025&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=oM1Lw4ta8-Q8bg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRQIgLWQqWAz37v_4hYNleTJEr1f0v3v_mqfskU04kCz-R4sCIQCdVuDDHtcBQCaD-aBoca5pQWbMaOMy3qZyT7u4e8if_w%3D%3D&sig=AJfQdSswRAIgFhN7_a7WyhbHFQ21jdWLw0F1ag3n5XPg_8D92MVttzsCIFiNqw4Wkz5rSEsLWTkZaVK_NTGyjpv3y9Qsm9JnRcgf&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 2 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":95,"duration":205,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A Dios Le Pido","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qd.googlevideo.com/videoplayback?expire=1720973002&ei=aqKTZuLSCvmahcIPgJKlaA&ip=90.171.233.248&id=o-AFsq6joFWLbERkW4ZJIZkIIhqkgRcuG3XI_TtVLZDCfz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=kR&mm=31%2C26&mn=sn-w511uxa-h5qd%2Csn-5hne6n6l&ms=au%2Conr&mv=m&mvi=3&pcm2cms=yes&pl=21&gcr=es&initcwndbps=2668750&bui=AXc671JI_mzee2vXPY65LJ_ia2MxybPjcWbHjRJHyXxafSiPF4B0twiTJXIxKDFbim1JvLZYv7GraS7G&spc=NO7bAa6-d1SRIb1_7DbUnzKRKxOWw8jKRohPHY0-nDruNuVW2g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=xz8gmRGBdnQaM7EFj8fT-n8Q&rqh=1&gir=yes&clen=3499238&dur=205.381&lmt=1714879641827443&mt=1720951025&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=oM1Lw4ta8-Q8bg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRQIgLWQqWAz37v_4hYNleTJEr1f0v3v_mqfskU04kCz-R4sCIQCdVuDDHtcBQCaD-aBoca5pQWbMaOMy3qZyT7u4e8if_w%3D%3D&sig=AJfQdSswRAIgFhN7_a7WyhbHFQ21jdWLw0F1ag3n5XPg_8D92MVttzsCIFiNqw4Wkz5rSEsLWTkZaVK_NTGyjpv3y9Qsm9JnRcgf&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 2 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":95,"duration":205,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A Dios Le Pido","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qd.googlevideo.com/videoplayback?expire=1720973002&ei=aqKTZuLSCvmahcIPgJKlaA&ip=90.171.233.248&id=o-AFsq6joFWLbERkW4ZJIZkIIhqkgRcuG3XI_TtVLZDCfz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=kR&mm=31%2C26&mn=sn-w511uxa-h5qd%2Csn-5hne6n6l&ms=au%2Conr&mv=m&mvi=3&pcm2cms=yes&pl=21&gcr=es&initcwndbps=2668750&bui=AXc671JI_mzee2vXPY65LJ_ia2MxybPjcWbHjRJHyXxafSiPF4B0twiTJXIxKDFbim1JvLZYv7GraS7G&spc=NO7bAa6-d1SRIb1_7DbUnzKRKxOWw8jKRohPHY0-nDruNuVW2g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=xz8gmRGBdnQaM7EFj8fT-n8Q&rqh=1&gir=yes&clen=3499238&dur=205.381&lmt=1714879641827443&mt=1720951025&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=oM1Lw4ta8-Q8bg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRQIgLWQqWAz37v_4hYNleTJEr1f0v3v_mqfskU04kCz-R4sCIQCdVuDDHtcBQCaD-aBoca5pQWbMaOMy3qZyT7u4e8if_w%3D%3D&sig=AJfQdSswRAIgFhN7_a7WyhbHFQ21jdWLw0F1ag3n5XPg_8D92MVttzsCIFiNqw4Wkz5rSEsLWTkZaVK_NTGyjpv3y9Qsm9JnRcgf&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 2 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 2 Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":95,"duration":205,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A Dios Le Pido","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qd.googlevideo.com/videoplayback?expire=1720973002&ei=aqKTZuLSCvmahcIPgJKlaA&ip=90.171.233.248&id=o-AFsq6joFWLbERkW4ZJIZkIIhqkgRcuG3XI_TtVLZDCfz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=kR&mm=31%2C26&mn=sn-w511uxa-h5qd%2Csn-5hne6n6l&ms=au%2Conr&mv=m&mvi=3&pcm2cms=yes&pl=21&gcr=es&initcwndbps=2668750&bui=AXc671JI_mzee2vXPY65LJ_ia2MxybPjcWbHjRJHyXxafSiPF4B0twiTJXIxKDFbim1JvLZYv7GraS7G&spc=NO7bAa6-d1SRIb1_7DbUnzKRKxOWw8jKRohPHY0-nDruNuVW2g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=xz8gmRGBdnQaM7EFj8fT-n8Q&rqh=1&gir=yes&clen=3499238&dur=205.381&lmt=1714879641827443&mt=1720951025&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=oM1Lw4ta8-Q8bg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRQIgLWQqWAz37v_4hYNleTJEr1f0v3v_mqfskU04kCz-R4sCIQCdVuDDHtcBQCaD-aBoca5pQWbMaOMy3qZyT7u4e8if_w%3D%3D&sig=AJfQdSswRAIgFhN7_a7WyhbHFQ21jdWLw0F1ag3n5XPg_8D92MVttzsCIFiNqw4Wkz5rSEsLWTkZaVK_NTGyjpv3y9Qsm9JnRcgf&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:26 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 2 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:26 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ------------------------------ 65ms Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ------------------------------ 63ms Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ------------------------------ 61ms Jul 14 12:03:26 volumiopi3 volumio[1067]: info: ------------------------------ 59ms Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:26 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:26 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:26 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:26 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:26 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:26 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:26 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CoreStateMachine::startPlaybackTimer Jul 14 12:03:26 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 3 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 3 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: ControllerMpd::getState Jul 14 12:03:27 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Jul 14 12:03:27 volumiopi3 volumio[1067]: info: sendMpdCommand status took 9 milliseconds Jul 14 12:03:27 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseState Jul 14 12:03:27 volumiopi3 volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 12:03:27 volumiopi3 volumio[1067]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 14 12:03:27 volumiopi3 volumio[1067]: verbose: ControllerMpd::parseTrackInfo Jul 14 12:03:27 volumiopi3 volumio[1067]: info: ControllerMpd::pushState Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreCommandRouter::servicePushState Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CorePlayQueue::getTrack 3 Jul 14 12:03:27 volumiopi3 volumio[1067]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1219,"duration":205,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A Dios Le Pido","artist":"Juanes","album":"Un Día Normal","uri":"https://rr3---sn-w511uxa-h5qd.googlevideo.com/videoplayback?expire=1720973002&ei=aqKTZuLSCvmahcIPgJKlaA&ip=90.171.233.248&id=o-AFsq6joFWLbERkW4ZJIZkIIhqkgRcuG3XI_TtVLZDCfz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=kR&mm=31%2C26&mn=sn-w511uxa-h5qd%2Csn-5hne6n6l&ms=au%2Conr&mv=m&mvi=3&pcm2cms=yes&pl=21&gcr=es&initcwndbps=2668750&bui=AXc671JI_mzee2vXPY65LJ_ia2MxybPjcWbHjRJHyXxafSiPF4B0twiTJXIxKDFbim1JvLZYv7GraS7G&spc=NO7bAa6-d1SRIb1_7DbUnzKRKxOWw8jKRohPHY0-nDruNuVW2g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=xz8gmRGBdnQaM7EFj8fT-n8Q&rqh=1&gir=yes&clen=3499238&dur=205.381&lmt=1714879641827443&mt=1720951025&fvip=2&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=oM1Lw4ta8-Q8bg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHlkHjAwRQIgLWQqWAz37v_4hYNleTJEr1f0v3v_mqfskU04kCz-R4sCIQCdVuDDHtcBQCaD-aBoca5pQWbMaOMy3qZyT7u4e8if_w%3D%3D&sig=AJfQdSswRAIgFhN7_a7WyhbHFQ21jdWLw0F1ag3n5XPg_8D92MVttzsCIFiNqw4Wkz5rSEsLWTkZaVK_NTGyjpv3y9Qsm9JnRcgf&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Jul 14 12:03:27 volumiopi3 volumio[1067]: verbose: CURRENT POSITION 3 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState stateService play Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreStateMachine::syncState currentStatus play Jul 14 12:03:27 volumiopi3 volumio[1067]: info: Received an update from plugin. extracting info from payload Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreStateMachine::pushState Jul 14 12:03:27 volumiopi3 volumio[1067]: info: CoreCommandRouter::volumioPushState Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:27 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:27 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - volume level for loudness 64 gain applied 0.00 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - Loudness is ON true Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - Nulleq applied Jul 14 12:03:27 volumiopi3 volumio[1067]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:27 volumiopi3 volumio[1067]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 14 12:03:29 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 14 12:03:29 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Starting Uninstall of plugin system_controller - crossfader_switch Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Uninstalling plugin crossfader_switch Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Disabling plugin crossfader_switch Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Checking if uninstall.sh is present Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Executing uninstall.sh Jul 14 12:03:38 volumiopi3 sudo[4936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_controller/crossfader_switch/uninstall.sh Jul 14 12:03:38 volumiopi3 sudo[4936]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 12:03:38 volumiopi3 sudo[4936]: pam_unix(sudo:session): session closed for user root Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Uninstall script completed Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Removing plugin crossfader_switch from configuration Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Successfully removed crossfader_switch configuration files Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Plugin folders cleanup Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning into folder /volumio/app/plugins/ Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category audio_interface Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category miscellanea Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category music_service Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category plugins.json Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category system_controller Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category user_interface Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning into folder /data/plugins/ Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category audio_interface Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category music_service Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category system_controller Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Cleaning folder for crossfader_switch Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category system_hardware Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Scanning category user_interface Jul 14 12:03:38 volumiopi3 volumio[1067]: info: Plugin folders cleanup completed Jul 14 12:03:38 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 14 12:03:38 volumiopi3 volumio[1067]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.53","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Calm Radio","name":"calmradio","category":"music_service","version":"1.2.4","icon":"fa-heartbeat","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"MotherEarthRadio","name":"motherearthradio","category":"music_service","version":"1.2.2","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.12","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.0.5","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"1.1.6","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.0.7","icon":"fa-youtube","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.1.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Music Services Shield","name":"music_services_shield","category":"system_hardware","version":"1.3.1","icon":"fa-shield","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Peppy-spectrum","name":"peppyspectrum","category":"user_interface","version":"0.0.26","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Touch Display","name":"touch_display","category":"user_interface","version":"3.4.0","icon":"fa-hand-pointer-o","isManuallyInstalled":false,"enabled":false,"active":false}] Jul 14 12:03:38 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 14 12:03:44 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 14 12:03:44 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 14 12:04:05 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 14 12:04:13 volumiopi3 volumio[1067]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ampswitch/volumio/buster/armhf Jul 14 12:04:14 volumiopi3 volumio[1067]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ampswitch/volumio/buster/armhf Jul 14 12:04:14 volumiopi3 volumio[1067]: info: Folder /tmp/plugins removed Jul 14 12:04:15 volumiopi3 volumio[1067]: info: Check plugin dependencies Jul 14 12:04:15 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 12:04:15 volumiopi3 volumio[1067]: info: Checking if plugin already exists Jul 14 12:04:15 volumiopi3 volumio[1067]: info: Rename folder Jul 14 12:04:15 volumiopi3 volumio[1067]: info: Folder /tmp/downloaded_plugin.zip removed Jul 14 12:04:15 volumiopi3 volumio[1067]: info: Move to category Jul 14 12:04:15 volumiopi3 volumio[1067]: info: Checking if install.sh is present Jul 14 12:04:15 volumiopi3 volumio[1067]: info: Executing install.sh Jul 14 12:04:16 volumiopi3 sudo[5001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_controller/ampswitch/install.sh Jul 14 12:04:16 volumiopi3 sudo[5001]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 12:04:16 volumiopi3 volumio[1067]: Plugin install end detected on script Jul 14 12:04:16 volumiopi3 sudo[5001]: pam_unix(sudo:session): session closed for user root Jul 14 12:04:16 volumiopi3 volumio[1067]: info: Install script completed Jul 14 12:04:16 volumiopi3 volumio[1067]: info: Adding reference to registry Jul 14 12:04:16 volumiopi3 volumio[1067]: info: Done installing plugin. Jul 14 12:04:16 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 14 12:04:16 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 14 12:04:16 volumiopi3 volumio[1067]: info: Folder /tmp/plugins removed Jul 14 12:04:16 volumiopi3 volumio[1067]: info: Folder /tmp/downloaded_plugin.zip removed Jul 14 12:04:16 volumiopi3 volumio[1067]: info: Folder /data/temp removed Jul 14 12:04:16 volumiopi3 volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 12:04:17 volumiopi3 volumio[1067]: info: Enabling plugin ampswitch Jul 14 12:04:17 volumiopi3 volumio[1067]: info: Loading plugin "ampswitch"... Jul 14 12:04:17 volumiopi3 volumio[1067]: info: PLUGIN START: ampswitch Jul 14 12:04:17 volumiopi3 volumio[1067]: info: Error: Error: EBUSY: resource busy or locked, write Jul 14 12:04:17 volumiopi3 volumio[1067]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 14 12:04:29 volumiopi3 volumio[1067]: info: Enabling plugin ampswitch Jul 14 12:04:29 volumiopi3 volumio[1067]: info: Loading plugin "ampswitch"... Jul 14 12:04:29 volumiopi3 volumio[1067]: info: Applying required configuration parameters for plugin ampswitch Jul 14 12:04:29 volumiopi3 volumio[1067]: info: PLUGIN START: ampswitch Jul 14 12:04:29 volumiopi3 volumio[1067]: info: Error: Error: EBUSY: resource busy or locked, write Jul 14 12:04:31 volumiopi3 volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 14 12:04:31 volumiopi3 volumio[1067]: info: [ASDebug] Setting UI defaults Jul 14 12:04:31 volumiopi3 volumio[1067]: info: [ASDebug] Port: 24 Jul 14 12:04:31 volumiopi3 volumio[1067]: info: [ASDebug] Inverted: false Jul 14 12:04:31 volumiopi3 volumio[1067]: info: [ASDebug] Latched: false Jul 14 12:04:31 volumiopi3 volumio[1067]: info: [ASDebug] On pulse width: 500 Jul 14 12:04:31 volumiopi3 volumio[1067]: info: [ASDebug] Off pulse width: 500 Jul 14 12:04:38 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 14 12:04:38 volumiopi3 volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 14 12:04:47 volumiopi3 volumio[1067]: info: Starting Uninstall of plugin system_controller - ampswitch Jul 14 12:04:47 volumiopi3 volumio[1067]: info: Uninstalling plugin ampswitch Jul 14 12:04:47 volumiopi3 volumio[1067]: info: [ASDebug] Port: 24 Jul 14 12:04:47 volumiopi3 volumio[1067]: info: [ASDebug] Inverted: false Jul 14 12:04:47 volumiopi3 volumio[1067]: info: [ASDebug] Delay: 720 Jul 14 12:04:47 volumiopi3 volumio[1067]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 12:04:47 volumiopi3 volumio[1067]: TypeError: Cannot read property 'unexport' of undefined Jul 14 12:04:47 volumiopi3 volumio[1067]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:234:19) Jul 14 12:04:47 volumiopi3 volumio[1067]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:84:10) Jul 14 12:04:47 volumiopi3 volumio[1067]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jul 14 12:04:47 volumiopi3 volumio[1067]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Jul 14 12:04:47 volumiopi3 volumio[1067]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1465:22) Jul 14 12:04:47 volumiopi3 volumio[1067]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1239:45) Jul 14 12:04:47 volumiopi3 volumio[1067]: at Socket.emit (events.js:315:20) Jul 14 12:04:47 volumiopi3 volumio[1067]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 14 12:04:47 volumiopi3 volumio[1067]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 14 12:04:47 volumiopi3 volumio[1067]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 12:04:48 volumiopi3 sudo[5056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 12:03 Jul 14 12:04:48 volumiopi3 sudo[5056]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"