Jun 17 14:49:15 macaca-volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 17 14:49:15 macaca-volumio dbus-daemon[715]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.7326' (uid=0 pid=528458 comm="timedatectl show --property=NTPSynchronized --valu") Jun 17 14:49:15 macaca-volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 17 14:49:15 macaca-volumio dbus-daemon[715]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 17 14:49:15 macaca-volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 17 14:49:15 macaca-volumio setdatetime-helper.sh[528457]: Time is already synchronized. Jun 17 14:49:15 macaca-volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 17 14:49:15 macaca-volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 17 14:49:31 macaca-volumio wpa_supplicant[1112]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 17 14:49:32 macaca-volumio wpa_supplicant[1112]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 17 14:49:45 macaca-volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 17 14:50:02 macaca-volumio wpa_supplicant[1112]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 17 14:50:05 macaca-volumio wpa_supplicant[1112]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 17 14:50:09 macaca-volumio wpa_supplicant[1112]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 17 14:50:13 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 8 Jun 17 14:50:13 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Prefetching next song Jun 17 14:50:13 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1750164613&ei=JRBRaKKuDtutvcAPzvTDwAI&ip=114.32.69.88&id=o-ALOYkXSWX3mKQUnFKkOFMU4ieOmXt0Vja0cIAz27B-dB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750143013%2C&mh=Lm&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57snee&ms=au%2Crdu&mv=m&mvi=3&pl=24&rms=au%2Cau&initcwndbps=2858750&bui=AY1jyLNDjtmEG2irp4NWjPAeiPv1DmutdUDtBP3kYEFniWarBslLM-F6aABaRhLru3STtr-1hbV2fvPC&spc=l3OVKTrGVeklmOb_ZzdK_8dZjFxuXatr3mnpAOQJ9BAQxrkt8GfXzJYZBjYtjbaAnIo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=2Rh5EKi-jBmoV7DnI0Q6NxoQ&rqh=1&gir=yes&clen=4724094&dur=296.241&lmt=1747202560939108&mt=1750142486&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532534&n=5jrYy_jrmPUAcw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMl-ECau0aq_Z-OuKs8R0gV8ej2ReipBVeBkrHoH3BhXAiBUJ-wvc4-_F3HWE8IpuxV2SIcZ_lkwFjtXx1FIymphpw%3D%3D&sig=AJfQdSswRAIgZZ0fishhIfOQSdoTQhS13EIpvhDbUM1HLkQW9rH-fX0CIErcv47wQzBxrFTggOBAUXulq8Op0Dkoy1aY4Se3xjPF&pot=MnjjcVhVMGIXQ-NNOt0BQCAfdTDtCThH1hhypIcfvSakiYnOLgnEmo0XYvvsPycrFUR3GImTiCjo1AejcqLsNApujWQUiTDS88c-t50VEsD66DimfGVwlBbQkjXUc59uguzRFf-SJay_8_9VNflVpH0_lTIR7Qq6MUg%3D&cver=1.20250219.01.00&t.YouTube" Jun 17 14:50:13 macaca-volumio volumio[1277]: info: sendMpdCommand addid "https://rr3---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1750164613&ei=JRBRaKKuDtutvcAPzvTDwAI&ip=114.32.69.88&id=o-ALOYkXSWX3mKQUnFKkOFMU4ieOmXt0Vja0cIAz27B-dB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750143013%2C&mh=Lm&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57snee&ms=au%2Crdu&mv=m&mvi=3&pl=24&rms=au%2Cau&initcwndbps=2858750&bui=AY1jyLNDjtmEG2irp4NWjPAeiPv1DmutdUDtBP3kYEFniWarBslLM-F6aABaRhLru3STtr-1hbV2fvPC&spc=l3OVKTrGVeklmOb_ZzdK_8dZjFxuXatr3mnpAOQJ9BAQxrkt8GfXzJYZBjYtjbaAnIo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=2Rh5EKi-jBmoV7DnI0Q6NxoQ&rqh=1&gir=yes&clen=4724094&dur=296.241&lmt=1747202560939108&mt=1750142486&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532534&n=5jrYy_jrmPUAcw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMl-ECau0aq_Z-OuKs8R0gV8ej2ReipBVeBkrHoH3BhXAiBUJ-wvc4-_F3HWE8IpuxV2SIcZ_lkwFjtXx1FIymphpw%3D%3D&sig=AJfQdSswRAIgZZ0fishhIfOQSdoTQhS13EIpvhDbUM1HLkQW9rH-fX0CIErcv47wQzBxrFTggOBAUXulq8Op0Dkoy1aY4Se3xjPF&pot=MnjjcVhVMGIXQ-NNOt0BQCAfdTDtCThH1hhypIcfvSakiYnOLgnEmo0XYvvsPycrFUR3GImTiCjo1AejcqLsNApujWQUiTDS88c-t50VEsD66DimfGVwlBbQkjXUc59uguzRFf-SJay_8_9VNflVpH0_lTIR7Qq6MUg%3D&cver=1.20250219.01.00&t.YouTube" took 2 milliseconds Jun 17 14:50:13 macaca-volumio volumio[1277]: verbose: MPD COMMAND [object Object] Jun 17 14:50:13 macaca-volumio volumio[1277]: verbose: MPD COMMAND [object Object] Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Jun 17 14:50:13 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Jun 17 14:50:13 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Jun 17 14:50:13 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Jun 17 14:50:13 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: ------------------------------ 3ms Jun 17 14:50:13 macaca-volumio volumio[1277]: info: [ytmusic-play] Prefetched and added track to MPD queue: 賜物 - Tamamono Jun 17 14:50:13 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand consume 1 Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Jun 17 14:50:13 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Jun 17 14:50:13 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:13 macaca-volumio volumio[1277]: info: ------------------------------ 6ms Jun 17 14:50:13 macaca-volumio volumio[1277]: info: ------------------------------ 5ms Jun 17 14:50:13 macaca-volumio volumio[1277]: info: ------------------------------ 5ms Jun 17 14:50:13 macaca-volumio volumio[1277]: info: sendMpdCommand consume 1 took 4 milliseconds Jun 17 14:50:13 macaca-volumio volumio[1277]: info: ------------------------------ 3ms Jun 17 14:50:13 macaca-volumio volumio[1277]: info: ------------------------------ 3ms Jun 17 14:50:17 macaca-volumio volumio[1277]: info: CoreStateMachine::startPlaybackTimer Jun 17 14:50:17 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:17 macaca-volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 17 14:50:17 macaca-volumio dbus-daemon[715]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.7328' (uid=0 pid=528679 comm="timedatectl show --property=NTPSynchronized --valu") Jun 17 14:50:17 macaca-volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 17 14:50:17 macaca-volumio dbus-daemon[715]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 17 14:50:17 macaca-volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 17 14:50:17 macaca-volumio setdatetime-helper.sh[528678]: Time is already synchronized. Jun 17 14:50:17 macaca-volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 17 14:50:17 macaca-volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Jun 17 14:50:18 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Jun 17 14:50:18 macaca-volumio volumio[1277]: ---------------------------- MPD announces state update: player Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ControllerMpd::getState Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand status Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Jun 17 14:50:18 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Jun 17 14:50:18 macaca-volumio volumio[1277]: ---------------------------- MPD announces state update: player Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ControllerMpd::getState Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand status Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Jun 17 14:50:18 macaca-volumio volumio[1277]: ---------------------------- MPD announces system playlist update Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Ignoring MPD Status Update Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ControllerMpd::getState Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand status Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Jun 17 14:50:18 macaca-volumio volumio[1277]: ---------------------------- MPD announces state update: player Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ControllerMpd::getState Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand status Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ------------------------------ 9ms Jun 17 14:50:18 macaca-volumio volumio[1277]: info: sendMpdCommand status took 10 milliseconds Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ------------------------------ 9ms Jun 17 14:50:18 macaca-volumio volumio[1277]: info: sendMpdCommand status took 8 milliseconds Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::parseState Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::parseState Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 14:50:18 macaca-volumio volumio[1277]: info: sendMpdCommand status took 14 milliseconds Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ------------------------------ 16ms Jun 17 14:50:18 macaca-volumio volumio[1277]: info: sendMpdCommand status took 12 milliseconds Jun 17 14:50:18 macaca-volumio volumio[1277]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 17 14:50:18 macaca-volumio volumio[1277]: info: sendMpdCommand playlistinfo took 9 milliseconds Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::parseState Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::parseState Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::parseTrackInfo Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::parseTrackInfo Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ControllerMpd::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::servicePushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: STATE SERVICE {"status":"play","position":0,"seek":39,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"賜物 - Tamamono","artist":"RADWIMPS","album":null,"uri":"https://rr3---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1750164613&ei=JRBRaKKuDtutvcAPzvTDwAI&ip=114.32.69.88&id=o-ALOYkXSWX3mKQUnFKkOFMU4ieOmXt0Vja0cIAz27B-dB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750143013%2C&mh=Lm&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57snee&ms=au%2Crdu&mv=m&mvi=3&pl=24&rms=au%2Cau&initcwndbps=2858750&bui=AY1jyLNDjtmEG2irp4NWjPAeiPv1DmutdUDtBP3kYEFniWarBslLM-F6aABaRhLru3STtr-1hbV2fvPC&spc=l3OVKTrGVeklmOb_ZzdK_8dZjFxuXatr3mnpAOQJ9BAQxrkt8GfXzJYZBjYtjbaAnIo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=2Rh5EKi-jBmoV7DnI0Q6NxoQ&rqh=1&gir=yes&clen=4724094&dur=296.241&lmt=1747202560939108&mt=1750142486&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532534&n=5jrYy_jrmPUAcw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMl-ECau0aq_Z-OuKs8R0gV8ej2ReipBVeBkrHoH3BhXAiBUJ-wvc4-_F3HWE8IpuxV2SIcZ_lkwFjtXx1FIymphpw%3D%3D&sig=AJfQdSswRAIgZZ0fishhIfOQSdoTQhS13EIpvhDbUM1HLkQW9rH-fX0CIErcv47wQzBxrFTggOBAUXulq8Op0Dkoy1aY4Se3xjPF&pot=MnjjcVhVMGIXQ-NNOt0BQCAfdTDtCThH1hhypIcfvSakiYnOLgnEmo0XYvvsPycrFUR3GImTiCjo1AejcqLsNApujWQUiTDS88c-t50VEsD66DimfGVwlBbQkjXUc59uguzRFf-SJay_8_9VNflVpH0_lTIR7Qq6MUg%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: CURRENT POSITION 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::syncState stateService play Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::syncState currentStatus play Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Received an update from plugin. extracting info from payload Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ControllerMpd::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::servicePushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: STATE SERVICE {"status":"play","position":0,"seek":39,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"賜物 - Tamamono","artist":"RADWIMPS","album":null,"uri":"https://rr3---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1750164613&ei=JRBRaKKuDtutvcAPzvTDwAI&ip=114.32.69.88&id=o-ALOYkXSWX3mKQUnFKkOFMU4ieOmXt0Vja0cIAz27B-dB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750143013%2C&mh=Lm&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57snee&ms=au%2Crdu&mv=m&mvi=3&pl=24&rms=au%2Cau&initcwndbps=2858750&bui=AY1jyLNDjtmEG2irp4NWjPAeiPv1DmutdUDtBP3kYEFniWarBslLM-F6aABaRhLru3STtr-1hbV2fvPC&spc=l3OVKTrGVeklmOb_ZzdK_8dZjFxuXatr3mnpAOQJ9BAQxrkt8GfXzJYZBjYtjbaAnIo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=2Rh5EKi-jBmoV7DnI0Q6NxoQ&rqh=1&gir=yes&clen=4724094&dur=296.241&lmt=1747202560939108&mt=1750142486&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532534&n=5jrYy_jrmPUAcw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMl-ECau0aq_Z-OuKs8R0gV8ej2ReipBVeBkrHoH3BhXAiBUJ-wvc4-_F3HWE8IpuxV2SIcZ_lkwFjtXx1FIymphpw%3D%3D&sig=AJfQdSswRAIgZZ0fishhIfOQSdoTQhS13EIpvhDbUM1HLkQW9rH-fX0CIErcv47wQzBxrFTggOBAUXulq8Op0Dkoy1aY4Se3xjPF&pot=MnjjcVhVMGIXQ-NNOt0BQCAfdTDtCThH1hhypIcfvSakiYnOLgnEmo0XYvvsPycrFUR3GImTiCjo1AejcqLsNApujWQUiTDS88c-t50VEsD66DimfGVwlBbQkjXUc59uguzRFf-SJay_8_9VNflVpH0_lTIR7Qq6MUg%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: CURRENT POSITION 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::syncState stateService play Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::syncState currentStatus play Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Received an update from plugin. extracting info from payload Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ------------------------------ 67ms Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ------------------------------ 65ms Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: sendMpdCommand playlistinfo took 55 milliseconds Jun 17 14:50:18 macaca-volumio volumio[1277]: info: sendMpdCommand playlistinfo took 55 milliseconds Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::parseTrackInfo Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: ControllerMpd::parseTrackInfo Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ControllerMpd::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::servicePushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: STATE SERVICE {"status":"play","position":0,"seek":39,"duration":296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"賜物 - Tamamono","artist":"RADWIMPS","album":null,"uri":"https://rr3---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1750164613&ei=JRBRaKKuDtutvcAPzvTDwAI&ip=114.32.69.88&id=o-ALOYkXSWX3mKQUnFKkOFMU4ieOmXt0Vja0cIAz27B-dB&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750143013%2C&mh=Lm&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57snee&ms=au%2Crdu&mv=m&mvi=3&pl=24&rms=au%2Cau&initcwndbps=2858750&bui=AY1jyLNDjtmEG2irp4NWjPAeiPv1DmutdUDtBP3kYEFniWarBslLM-F6aABaRhLru3STtr-1hbV2fvPC&spc=l3OVKTrGVeklmOb_ZzdK_8dZjFxuXatr3mnpAOQJ9BAQxrkt8GfXzJYZBjYtjbaAnIo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=2Rh5EKi-jBmoV7DnI0Q6NxoQ&rqh=1&gir=yes&clen=4724094&dur=296.241&lmt=1747202560939108&mt=1750142486&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532534&n=5jrYy_jrmPUAcw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMl-ECau0aq_Z-OuKs8R0gV8ej2ReipBVeBkrHoH3BhXAiBUJ-wvc4-_F3HWE8IpuxV2SIcZ_lkwFjtXx1FIymphpw%3D%3D&sig=AJfQdSswRAIgZZ0fishhIfOQSdoTQhS13EIpvhDbUM1HLkQW9rH-fX0CIErcv47wQzBxrFTggOBAUXulq8Op0Dkoy1aY4Se3xjPF&pot=MnjjcVhVMGIXQ-NNOt0BQCAfdTDtCThH1hhypIcfvSakiYnOLgnEmo0XYvvsPycrFUR3GImTiCjo1AejcqLsNApujWQUiTDS88c-t50VEsD66DimfGVwlBbQkjXUc59uguzRFf-SJay_8_9VNflVpH0_lTIR7Qq6MUg%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 17 14:50:18 macaca-volumio volumio[1277]: verbose: CURRENT POSITION 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::syncState stateService play Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::syncState currentStatus play Jun 17 14:50:18 macaca-volumio volumio[1277]: info: Received an update from plugin. extracting info from payload Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:18 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:18 macaca-volumio volumio[1277]: info: ------------------------------ 88ms Jun 17 14:50:18 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Jun 17 14:50:18 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Jun 17 14:50:18 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Jun 17 14:50:18 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Jun 17 14:50:18 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Jun 17 14:50:18 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Jun 17 14:50:18 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Jun 17 14:50:34 macaca-volumio volumio[1277]: info: VolumeController::SetAlsaVolume31 Jun 17 14:50:34 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:34 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:34 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 14:50:34 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:34 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Jun 17 14:50:34 macaca-volumio volumio[1277]: SPOTIFY: SPOTIFY VOLUME 34 Jun 17 14:50:34 macaca-volumio volumio[1277]: SPOTIFY: VOLUMIO VOLUME 31 Jun 17 14:50:34 macaca-volumio volumio[1277]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 17 14:50:34 macaca-volumio volumio[1277]: info: Setting Spotify Volume from Volumio: 31 Jun 17 14:50:34 macaca-volumio volumio[1277]: info: VolumeController::SetAlsaVolume28 Jun 17 14:50:34 macaca-volumio volumio[1277]: info: CoreStateMachine::pushState Jun 17 14:50:34 macaca-volumio volumio[1277]: info: CorePlayQueue::getTrack 9 Jun 17 14:50:34 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 14:50:34 macaca-volumio volumio[1277]: info: CoreCommandRouter::volumioPushState Jun 17 14:50:34 macaca-volumio volumio[1277]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Jun 17 14:50:34 macaca-volumio volumio[1277]: SPOTIFY: SPOTIFY VOLUME 31 Jun 17 14:50:34 macaca-volumio volumio[1277]: SPOTIFY: VOLUMIO VOLUME 28 Jun 17 14:50:34 macaca-volumio volumio[1277]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 17 14:50:34 macaca-volumio volumio[1277]: info: Setting Spotify Volume from Volumio: 28 Jun 17 14:50:36 macaca-volumio volumio[1277]: SPOTIFY: SETTING SPOTIFY VOLUME 28 Jun 17 14:50:36 macaca-volumio volumio[1277]: info: Sending Spotify command with payload to local API: /player/volume Jun 17 14:50:39 macaca-volumio volumio[1277]: Searching all installed plugins Jun 17 14:50:39 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 14:50:39 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: , search Jun 17 14:50:39 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 17 14:50:39 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jun 17 14:50:39 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jun 17 14:50:39 macaca-volumio volumio[1277]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jun 17 14:50:39 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 17 14:50:39 macaca-volumio volumio[1277]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jun 17 14:50:40 macaca-volumio volumio[1277]: Use XMLElement.setAttribute instead Jun 17 14:50:40 macaca-volumio volumio[1277]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 17 14:50:40 macaca-volumio volumio[1277]: TypeError: children[i].attr(...).value is not a function Jun 17 14:50:40 macaca-volumio volumio[1277]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 17 14:50:40 macaca-volumio volumio[1277]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 17 14:50:40 macaca-volumio volumio[1277]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 17 14:50:40 macaca-volumio sudo[528772]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-17 14:49' Jun 17 14:50:40 macaca-volumio sudo[528772]: 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="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 23 07:33:33 UTC 2025" VOLUMIO_VERSION="0.069" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="d67a2da4ffe3f001e986b1f31eaa3a76"