Dec 20 19:06:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1445 milliseconds Dec 20 19:06:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1446 milliseconds Dec 20 19:06:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1446 milliseconds Dec 20 19:06:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:01 purenrgtransfer volumio[1159]: info: Command Router : Notfying DB Updatefalse Dec 20 19:06:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::Close All Modals sent Dec 20 19:06:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2362 milliseconds Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2362 milliseconds Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2362 milliseconds Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: Command Router : Notfying DB Updatefalse Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::Close All Modals sent Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3259 milliseconds Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3259 milliseconds Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3259 milliseconds Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: Command Router : Notfying DB Updatefalse Dec 20 19:06:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::Close All Modals sent Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4329 milliseconds Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4329 milliseconds Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4330 milliseconds Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: Command Router : Notfying DB Updatefalse Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::Close All Modals sent Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2881 milliseconds Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2881 milliseconds Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104243,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104243,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:03 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:03 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ------------------------------ 4378ms Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ------------------------------ 4378ms Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2061 milliseconds Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2060 milliseconds Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104369,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104369,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ------------------------------ 4464ms Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ------------------------------ 4464ms Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 1187 milliseconds Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 1188 milliseconds Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104495,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104495,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ------------------------------ 4484ms Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ------------------------------ 4485ms Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 135 milliseconds Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 135 milliseconds Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104495,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104495,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:04 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ------------------------------ 4500ms Dec 20 19:06:04 purenrgtransfer volumio[1159]: info: ------------------------------ 4500ms Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:04 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand update Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Dec 20 19:06:08 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: update Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand update took 285 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Dec 20 19:06:08 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: update Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Dec 20 19:06:08 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: update Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Dec 20 19:06:08 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: update Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 115 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 114 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 115 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 114 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 114 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 114 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 113 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 113 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Command Router : Notfying DB Updatetrue Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::Close All Modals sent Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Command Router : Notfying DB Updatetrue Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::Close All Modals sent Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Command Router : Notfying DB Updatetrue Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::Close All Modals sent Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Command Router : Notfying DB Updatetrue Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::Close All Modals sent Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 127 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 118 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 113 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 108 milliseconds Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113245,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113245,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113245,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113245,"duration":5345,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Cello Music By H.A.U.S.E.R - H.A.U.S.E.R Top Covers of Popular Songs Collection","artist":"Beautiful CELLO Song","album":"YouTube","uri":"https://rr1---sn-uxax3vhgn-cxby.googlevideo.com/videoplayback?expire=1766275454&ei=HuVGaejRK4v-xN8Pn4Ph-AU&ip=213.196.103.56&id=o-AOW8VmBZeiARMBe25qpBAlWpPEPsZmftdrPL4kCfbrYO&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=0&met=1766253854%2C&mh=db&mm=31%2C29&mn=sn-uxax3vhgn-cxby%2Csn-c0q7lnly&ms=au%2Crdu&mv=m&mvi=1&pl=25&rms=au%2Cau&initcwndbps=966250&siu=1&bui=AYUSA3BJBhaFYA9hX4Zf8ss0irS_r8UgFzGi_YDcHft4Rr8kf-qmLHij1cXTxQJURM8hxDFmfg&spc=wH4Qq99zop0IfJSmHckI3zBnPhk7cab-N_gHILJZeXG8Z464-w&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=BeXKLAMNcRkqYv1YE_qx7mER&rqh=1&gir=yes&clen=91295599&dur=5345.061&lmt=1655652604765127&mt=1766253448&fvip=5&keepalive=yes&fexp=51552689%2C51565116%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5432434&n=fxA1a8hVQzth7g&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJEPMnSpyhqFKkGMSGasH4hxBmjB6QtD2c8ytfcC0_wsCIQCSBl_44gjlei_Y8qOhzF-fpoaS2zm5KZO8-ZFXdv46yw%3D%3D&sig=AJfQdSswRgIhAKuHrJqJzdsD75EWpRZvCSdDK7BleN79MA1Q_W83jIHAAiEAtw7cGkmVfF0vqo9lp1SPnZZ64U88INZ2DIbA9_c1vrE%3D&pot=MlVdrzHiYvgwnl2RXml9tdhcMZg07ouEezwFlbRHtsu7zixuHm5smMXyqn0r20GNXUVQIgiX3piD8VqsSLDMzJPXFk66wdD0PHVglWFUd_qMP20Vs9bt&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 20 19:06:08 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService play Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus play Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: Received an update from plugin. extracting info from payload Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:08 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:09 purenrgtransfer volumio[1159]: info: ------------------------------ 331ms Dec 20 19:06:09 purenrgtransfer volumio[1159]: info: ------------------------------ 330ms Dec 20 19:06:09 purenrgtransfer volumio[1159]: info: ------------------------------ 330ms Dec 20 19:06:09 purenrgtransfer volumio[1159]: info: ------------------------------ 329ms Dec 20 19:06:09 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:09 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:09 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:09 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:09 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:09 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:09 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:09 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:25 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:27 purenrgtransfer volumio[1159]: info: Executing endpoint metavolumio Dec 20 19:06:27 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 20 19:06:27 purenrgtransfer volumio[1159]: info: Executing endpoint metavolumio Dec 20 19:06:27 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 20 19:06:27 purenrgtransfer volumio[1159]: info: Executing endpoint metavolumio Dec 20 19:06:27 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Retrieving Cloud Streaming UI Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Getting Tidal Cloud Configuration Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Getting Qobuz Cloud Configuration Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Asking plugin for UI Config Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Getting Spotify Cloud Configuration Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Asking plugin for UI Config Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Saving Spotify Acccount Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Got it Dec 20 19:06:29 purenrgtransfer volumio[1159]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Got Tidal Cloud Configuration Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: Got it Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 19:06:29 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 20 19:06:33 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:35 purenrgtransfer volumio[1159]: info: Executing endpoint metavolumio Dec 20 19:06:35 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 20 19:06:36 purenrgtransfer volumio[1159]: info: Executing endpoint metavolumio Dec 20 19:06:36 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 20 19:06:36 purenrgtransfer volumio[1159]: info: Executing endpoint metavolumio Dec 20 19:06:36 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 20 19:06:41 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , handleBrowseUri Dec 20 19:06:41 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:46 purenrgtransfer volumio[1159]: info: Tunnel connection is inactive, restarting it Dec 20 19:06:46 purenrgtransfer volumio[1159]: info: Starting Tunnel 1 Dec 20 19:06:46 purenrgtransfer volumio[1159]: info: Starting Tunnel Connection Checker Dec 20 19:06:48 purenrgtransfer sudo[3988]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 20 19:06:48 purenrgtransfer sudo[3988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 19:06:48 purenrgtransfer autossh[3046]: received signal to exit (15) Dec 20 19:06:48 purenrgtransfer systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Dec 20 19:06:48 purenrgtransfer systemd[1]: sshtunnel.service: Deactivated successfully. Dec 20 19:06:48 purenrgtransfer systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Dec 20 19:06:48 purenrgtransfer systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 20 19:06:48 purenrgtransfer sudo[3988]: pam_unix(sudo:session): session closed for user root Dec 20 19:06:48 purenrgtransfer volumio[1159]: info: Remote SSH Started Dec 20 19:06:48 purenrgtransfer autossh[3991]: port set to 0, monitoring disabled Dec 20 19:06:48 purenrgtransfer autossh[3991]: starting ssh (count 1) Dec 20 19:06:48 purenrgtransfer autossh[3991]: ssh child pid is 3994 Dec 20 19:06:48 purenrgtransfer volumio[1159]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Dec 20 19:06:48 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:48 purenrgtransfer volumiossh-tunnel[3994]: Warning: Permanently added '[eu6.myvolumio.org]:2222' (RSA) to the list of known hosts. Dec 20 19:06:48 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Dec 20 19:06:48 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Preloading song: weblinn/0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Preloading song: weblinn/1 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Preloading song: weblinn/2 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Exploding uri weblinn/0 in service personal_radio Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Exploding uri weblinn/1 in service personal_radio Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Exploding uri weblinn/2 in service personal_radio Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::ClearQueue Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::stop Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::stPlaybackTimer Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::updateTrackBlock Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrackBlock Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::serviceStop Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::serviceStop Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: [youtube2] (AutoplayManager) Removed mpdStateListener Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: [youtube2] (AutoplayManager) Removed volumioStateListener Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: [youtube2] (AutoplayManager) Disabled Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ControllerMpd::stop Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::clearPlayQueue Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::addQueueItems Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::addQueueItems Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::updateTrackBlock Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrackBlock Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPlay Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::play index 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::addQueueItems Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::addQueueItems Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/1 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/1 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/2 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/2 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::stop Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::play index undefined Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::updateTrackBlock Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrackBlock Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::startPlaybackTimer Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 19:06:49 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand stop took 26 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand stop took 7 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand clear took 2 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8000/stream" Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 19ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 18ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 18ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:49 purenrgtransfer volumio[1159]: error: updateQueue error: null Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 21ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand add "http://radio.linnrecords.com:8000/stream" took 20 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 3ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 2ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 2ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:49 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand play Dec 20 19:06:49 purenrgtransfer volumio[1159]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 25ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Dec 20 19:06:49 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:49 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:49 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:49 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 17ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: sendMpdCommand play took 14 milliseconds Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 14ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 14ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: ------------------------------ 14ms Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 20 19:06:49 purenrgtransfer volumio[1159]: info: Pushing Favourites {"uri":"weblinn/0","favourite":false} Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: Dec 20 19:06:50 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: Dec 20 19:06:50 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: Dec 20 19:06:50 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: Dec 20 19:06:50 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: Dec 20 19:06:50 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: Dec 20 19:06:50 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: Dec 20 19:06:50 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: Dec 20 19:06:50 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 5 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 5 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 14 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 14 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 11 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 11 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 11 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 10 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 10 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 10 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ------------------------------ 84ms Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ------------------------------ 84ms Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ------------------------------ 84ms Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ------------------------------ 84ms Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ------------------------------ 84ms Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 99 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 99 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 97 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 97 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 98 milliseconds Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Dec 20 19:06:50 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 0 Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ------------------------------ 147ms Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ------------------------------ 147ms Dec 20 19:06:50 purenrgtransfer volumio[1159]: info: ------------------------------ 147ms Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:50 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::ClearQueue Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::clearPlayQueue Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::addQueueItems Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::addQueueItems Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/0 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/0 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::updateTrackBlock Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrackBlock Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 0 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPlay Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::play index 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::addQueueItems Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::addQueueItems Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/2 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/2 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::play index undefined Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::updateTrackBlock Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrackBlock Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::startPlaybackTimer Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand stop took 1 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand clear took 1 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8003/stream" Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:54 purenrgtransfer volumio[1159]: error: updateQueue error: null Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 2ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand add "http://radio.linnrecords.com:8003/stream" took 1 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand play Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 3ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand play took 2 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 2ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 2ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 5 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 5 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 5 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Dec 20 19:06:54 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 12 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 10 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 10 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 9 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 8 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 8 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 38ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 38ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 39ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 38ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 43 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 41 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Dec 20 19:06:54 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 1 Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 74ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 75ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 66ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: ------------------------------ 66ms Dec 20 19:06:54 purenrgtransfer volumio[1159]: info: Pushing Favourites {"uri":"weblinn/1","favourite":false} Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:54 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::ClearQueue Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::clearPlayQueue Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::addQueueItems Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::addQueueItems Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/0 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/0 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/1 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/1 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::updateTrackBlock Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrackBlock Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 1 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPlay Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::play index 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::play index undefined Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::startPlaybackTimer Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand stop took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand clear took 1 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8004/stream" Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:55 purenrgtransfer volumio[1159]: error: updateQueue error: null Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 2ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand add "http://radio.linnrecords.com:8004/stream" took 1 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand play Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 3ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand play took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Dec 20 19:06:55 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 16ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 17ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 21 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 21 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:06:55 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: No code Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 52ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 51ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 52ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 50ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 50ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: ------------------------------ 50ms Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:06:55 purenrgtransfer volumio[1159]: info: Pushing Favourites {"uri":"weblinn/2","favourite":false} Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::ClearQueue Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::clearPlayQueue Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::addQueueItems Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::addQueueItems Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/0 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/0 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/1 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/1 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Adding Item to queue: weblinn/2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Using cached record of: weblinn/2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushQueue Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::saveQueue Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::updateTrackBlock Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrackBlock Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPlay Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::play index 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::play index undefined Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::startPlaybackTimer Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand stop took 1 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand clear took 0 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8004/stream" Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:07:01 purenrgtransfer volumio[1159]: error: updateQueue error: null Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand add "http://radio.linnrecords.com:8004/stream" took 1 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 2ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand play Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces system playlist update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Ignoring MPD Status Update Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 3ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand play took 1 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 1ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Pushing Favourites {"uri":"weblinn/2","favourite":false} Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 3 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 2 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 6 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 4 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 4 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 4 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 4 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 4 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 1 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: No code Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: No code Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: No code Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: No code Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 28ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 28ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 29ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ------------------------------ 28ms Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: Dec 20 19:07:01 purenrgtransfer volumio[1159]: ---------------------------- MPD announces state update: player Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::getState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand status Dec 20 19:07:01 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:01 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:01 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:01 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:01 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:01 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand clearerror took 41 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 41 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 41 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 40 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: sendMpdCommand status took 19 milliseconds Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseState Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:07:01 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: No code Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:01 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:02 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:07:02 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: No code Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:02 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:07:02 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: No code Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: ------------------------------ 60ms Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: ------------------------------ 60ms Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: ------------------------------ 55ms Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 20 19:07:02 purenrgtransfer volumio[1159]: verbose: ControllerMpd::parseTrackInfo Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: ControllerMpd::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::servicePushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CorePlayQueue::getTrack 2 Dec 20 19:07:02 purenrgtransfer volumio[1159]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Dec 20 19:07:02 purenrgtransfer volumio[1159]: verbose: CURRENT POSITION 2 Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState stateService stop Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::syncState currentStatus stop Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: No code Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreStateMachine::pushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioPushState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output update for this device Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: MRS: Pushing multiroomSync output Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: CoreCommandRouter::volumioGetState Dec 20 19:07:02 purenrgtransfer volumio[1159]: info: ------------------------------ 43ms Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:02 purenrgtransfer volumio[1159]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Dec 20 19:07:04 purenrgtransfer volumio[1159]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Dec 20 19:07:04 purenrgtransfer volumio[1159]: info: Preload queue cleared Dec 20 19:07:04 purenrgtransfer volumio[1159]: info: Preloading song: websbs/0 Dec 20 19:07:04 purenrgtransfer volumio[1159]: info: Preloading song: websbs/1 Dec 20 19:07:04 purenrgtransfer volumio[1159]: info: Preloading song: websbs/2 Dec 20 19:07:04 purenrgtransfer volumio[1159]: info: Exploding uri websbs/0 in service personal_radio Dec 20 19:07:04 purenrgtransfer volumio[1159]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 19:07:04 purenrgtransfer volumio[1159]: TypeError: Cannot read properties of null (reading 'startsWith') Dec 20 19:07:04 purenrgtransfer volumio[1159]: at /data/plugins/music_service/personal_radio/index.js:675:41 Dec 20 19:07:04 purenrgtransfer volumio[1159]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 20 19:07:04 purenrgtransfer volumio[1159]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 19:07:04 purenrgtransfer sudo[4095]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-20 19:06' Dec 20 19:07:04 purenrgtransfer sudo[4095]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"