Jun 12 14:13:06 macaca-volumio wpa_supplicant[1107]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 12 14:13:11 macaca-volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 12 14:13:11 macaca-volumio dbus-daemon[851]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.3503' (uid=0 pid=282307 comm="timedatectl show --property=NTPSynchronized --valu") Jun 12 14:13:11 macaca-volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 12 14:13:11 macaca-volumio dbus-daemon[851]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 12 14:13:11 macaca-volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 12 14:13:11 macaca-volumio setdatetime-helper.sh[282306]: Time is already synchronized. Jun 12 14:13:11 macaca-volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 12 14:13:11 macaca-volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 12 14:13:14 macaca-volumio wpa_supplicant[1107]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 12 14:13:41 macaca-volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 12 14:13:47 macaca-volumio wpa_supplicant[1107]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 12 14:14:04 macaca-volumio wpa_supplicant[1107]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 12 14:14:29 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:29 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 23 Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Prefetching next song Jun 12 14:14:29 macaca-volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 12 14:14:29 macaca-volumio dbus-daemon[851]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.3505' (uid=0 pid=282582 comm="timedatectl show --property=NTPSynchronized --valu") Jun 12 14:14:29 macaca-volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 12 14:14:29 macaca-volumio dbus-daemon[851]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 12 14:14:29 macaca-volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 12 14:14:29 macaca-volumio setdatetime-helper.sh[282581]: Time is already synchronized. Jun 12 14:14:29 macaca-volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 12 14:14:29 macaca-volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 12 14:14:29 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1749730469&ei=RXBKaKW9E_icvcAPtsH0mA0&ip=114.32.69.88&id=o-ANpM6S6lPQfR0Gt20Q5is3it0wqnuQkoKxi48X-MLJr5&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749708869%2C&mh=s9&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57sn7y&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=tw&initcwndbps=2713750&bui=AY1jyLN_qUsP4KnM2PISISvEyX-yjM-t59OSS_oqw08qLPIAH4uS-X2de4Blp9Zi4vCiH6rMy1XWu-mb&spc=l3OVKVNNvoqTI8X74NlpGABreY42F7tzffdBFcjl5bb1eRPrpWVBKPBp8-HuG2zHF2I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1kojuWY9rYvScC9GhIC83WUQ&rqh=1&gir=yes&clen=5241952&dur=306.641&lmt=1714656050082314&mt=1749708540&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=xAMfXvYG_VCrAg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJzelmoeDbJm5M45Hdbnzvt2NQ2ZzStx_L3ElUN0nN24CIQCeqFS_DM3ZKCyZp07-k1C4dnBP4y8i9i2IfZFWrz1L6w%3D%3D&sig=AJfQdSswRQIgERKfypJ44L8QxqeknzM8lnGXgBXbz2XbDULRHig9YBACIQDI06aRiPWICImTHD9tVjY9bt-HWVQ7Liox8LqrUXRDQQ%3D%3D&pot=MniWGCaUtWEyGpYkj-UvL5szblut_IR_0Erefe1rx_ptQ_g-Y6BPRPoj4eA93pD4BNIVrxyqN5ohAAyAIR-FUPK1xR8AOCzUschrvhF5mcoZ1J1BhdZQRnOHC2pzd3mWLO1_BRRs7oe3YiadsUe5FPGFQE2joM1DHGQ%3D&cver=1.20250219.01.00&t.YouTube" Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Jun 12 14:14:29 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: sendMpdCommand addid "https://rr1---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1749730469&ei=RXBKaKW9E_icvcAPtsH0mA0&ip=114.32.69.88&id=o-ANpM6S6lPQfR0Gt20Q5is3it0wqnuQkoKxi48X-MLJr5&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749708869%2C&mh=s9&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57sn7y&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=tw&initcwndbps=2713750&bui=AY1jyLN_qUsP4KnM2PISISvEyX-yjM-t59OSS_oqw08qLPIAH4uS-X2de4Blp9Zi4vCiH6rMy1XWu-mb&spc=l3OVKVNNvoqTI8X74NlpGABreY42F7tzffdBFcjl5bb1eRPrpWVBKPBp8-HuG2zHF2I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1kojuWY9rYvScC9GhIC83WUQ&rqh=1&gir=yes&clen=5241952&dur=306.641&lmt=1714656050082314&mt=1749708540&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=xAMfXvYG_VCrAg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJzelmoeDbJm5M45Hdbnzvt2NQ2ZzStx_L3ElUN0nN24CIQCeqFS_DM3ZKCyZp07-k1C4dnBP4y8i9i2IfZFWrz1L6w%3D%3D&sig=AJfQdSswRQIgERKfypJ44L8QxqeknzM8lnGXgBXbz2XbDULRHig9YBACIQDI06aRiPWICImTHD9tVjY9bt-HWVQ7Liox8LqrUXRDQQ%3D%3D&pot=MniWGCaUtWEyGpYkj-UvL5szblut_IR_0Erefe1rx_ptQ_g-Y6BPRPoj4eA93pD4BNIVrxyqN5ohAAyAIR-FUPK1xR8AOCzUschrvhF5mcoZ1J1BhdZQRnOHC2pzd3mWLO1_BRRs7oe3YiadsUe5FPGFQE2joM1DHGQ%3D&cver=1.20250219.01.00&t.YouTube" took 8 milliseconds Jun 12 14:14:29 macaca-volumio volumio[1257]: verbose: MPD COMMAND [object Object] Jun 12 14:14:29 macaca-volumio volumio[1257]: verbose: MPD COMMAND [object Object] Jun 12 14:14:29 macaca-volumio volumio[1257]: verbose: MPD COMMAND [object Object] Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Jun 12 14:14:29 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Jun 12 14:14:29 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Jun 12 14:14:29 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: ------------------------------ 10ms Jun 12 14:14:29 macaca-volumio volumio[1257]: info: ------------------------------ 7ms Jun 12 14:14:29 macaca-volumio volumio[1257]: info: ------------------------------ 6ms Jun 12 14:14:29 macaca-volumio volumio[1257]: info: [ytmusic-play] Prefetched and added track to MPD queue: マリーゴールド - Marigold Jun 12 14:14:29 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand consume 1 Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Jun 12 14:14:29 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Jun 12 14:14:29 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:29 macaca-volumio volumio[1257]: info: ------------------------------ 10ms Jun 12 14:14:29 macaca-volumio volumio[1257]: info: sendMpdCommand consume 1 took 7 milliseconds Jun 12 14:14:29 macaca-volumio volumio[1257]: info: ------------------------------ 6ms Jun 12 14:14:29 macaca-volumio volumio[1257]: info: ------------------------------ 5ms Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Jun 12 14:14:32 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Jun 12 14:14:32 macaca-volumio volumio[1257]: ---------------------------- MPD announces state update: player Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ControllerMpd::getState Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Jun 12 14:14:32 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Jun 12 14:14:32 macaca-volumio volumio[1257]: ---------------------------- MPD announces state update: player Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ControllerMpd::getState Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Jun 12 14:14:32 macaca-volumio volumio[1257]: ---------------------------- MPD announces system playlist update Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Ignoring MPD Status Update Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ControllerMpd::getState Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Jun 12 14:14:32 macaca-volumio volumio[1257]: ---------------------------- MPD announces state update: player Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ControllerMpd::getState Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand status Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ------------------------------ 3ms Jun 12 14:14:32 macaca-volumio volumio[1257]: info: sendMpdCommand status took 2 milliseconds Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ------------------------------ 3ms Jun 12 14:14:32 macaca-volumio volumio[1257]: info: sendMpdCommand status took 3 milliseconds Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::parseState Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::parseState Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:14:32 macaca-volumio volumio[1257]: info: sendMpdCommand status took 3 milliseconds Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ------------------------------ 4ms Jun 12 14:14:32 macaca-volumio volumio[1257]: info: sendMpdCommand status took 3 milliseconds Jun 12 14:14:32 macaca-volumio volumio[1257]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 12 14:14:32 macaca-volumio volumio[1257]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::parseState Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::parseState Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ControllerMpd::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::servicePushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"マリーゴールド - Marigold","artist":"aimyon","album":"Marigold","uri":"https://rr1---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1749730469&ei=RXBKaKW9E_icvcAPtsH0mA0&ip=114.32.69.88&id=o-ANpM6S6lPQfR0Gt20Q5is3it0wqnuQkoKxi48X-MLJr5&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749708869%2C&mh=s9&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57sn7y&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=tw&initcwndbps=2713750&bui=AY1jyLN_qUsP4KnM2PISISvEyX-yjM-t59OSS_oqw08qLPIAH4uS-X2de4Blp9Zi4vCiH6rMy1XWu-mb&spc=l3OVKVNNvoqTI8X74NlpGABreY42F7tzffdBFcjl5bb1eRPrpWVBKPBp8-HuG2zHF2I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1kojuWY9rYvScC9GhIC83WUQ&rqh=1&gir=yes&clen=5241952&dur=306.641&lmt=1714656050082314&mt=1749708540&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=xAMfXvYG_VCrAg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJzelmoeDbJm5M45Hdbnzvt2NQ2ZzStx_L3ElUN0nN24CIQCeqFS_DM3ZKCyZp07-k1C4dnBP4y8i9i2IfZFWrz1L6w%3D%3D&sig=AJfQdSswRQIgERKfypJ44L8QxqeknzM8lnGXgBXbz2XbDULRHig9YBACIQDI06aRiPWICImTHD9tVjY9bt-HWVQ7Liox8LqrUXRDQQ%3D%3D&pot=MniWGCaUtWEyGpYkj-UvL5szblut_IR_0Erefe1rx_ptQ_g-Y6BPRPoj4eA93pD4BNIVrxyqN5ohAAyAIR-FUPK1xR8AOCzUschrvhF5mcoZ1J1BhdZQRnOHC2pzd3mWLO1_BRRs7oe3YiadsUe5FPGFQE2joM1DHGQ%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: CURRENT POSITION 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::syncState stateService play Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Received an update from plugin. extracting info from payload Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ControllerMpd::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::servicePushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"マリーゴールド - Marigold","artist":"aimyon","album":"Marigold","uri":"https://rr1---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1749730469&ei=RXBKaKW9E_icvcAPtsH0mA0&ip=114.32.69.88&id=o-ANpM6S6lPQfR0Gt20Q5is3it0wqnuQkoKxi48X-MLJr5&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749708869%2C&mh=s9&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57sn7y&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=tw&initcwndbps=2713750&bui=AY1jyLN_qUsP4KnM2PISISvEyX-yjM-t59OSS_oqw08qLPIAH4uS-X2de4Blp9Zi4vCiH6rMy1XWu-mb&spc=l3OVKVNNvoqTI8X74NlpGABreY42F7tzffdBFcjl5bb1eRPrpWVBKPBp8-HuG2zHF2I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1kojuWY9rYvScC9GhIC83WUQ&rqh=1&gir=yes&clen=5241952&dur=306.641&lmt=1714656050082314&mt=1749708540&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=xAMfXvYG_VCrAg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJzelmoeDbJm5M45Hdbnzvt2NQ2ZzStx_L3ElUN0nN24CIQCeqFS_DM3ZKCyZp07-k1C4dnBP4y8i9i2IfZFWrz1L6w%3D%3D&sig=AJfQdSswRQIgERKfypJ44L8QxqeknzM8lnGXgBXbz2XbDULRHig9YBACIQDI06aRiPWICImTHD9tVjY9bt-HWVQ7Liox8LqrUXRDQQ%3D%3D&pot=MniWGCaUtWEyGpYkj-UvL5szblut_IR_0Erefe1rx_ptQ_g-Y6BPRPoj4eA93pD4BNIVrxyqN5ohAAyAIR-FUPK1xR8AOCzUschrvhF5mcoZ1J1BhdZQRnOHC2pzd3mWLO1_BRRs7oe3YiadsUe5FPGFQE2joM1DHGQ%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: CURRENT POSITION 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::syncState stateService play Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Received an update from plugin. extracting info from payload Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ------------------------------ 21ms Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ------------------------------ 21ms Jun 12 14:14:32 macaca-volumio volumio[1257]: info: sendMpdCommand playlistinfo took 17 milliseconds Jun 12 14:14:32 macaca-volumio volumio[1257]: info: sendMpdCommand playlistinfo took 17 milliseconds Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: ControllerMpd::parseTrackInfo Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ControllerMpd::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::servicePushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"マリーゴールド - Marigold","artist":"aimyon","album":"Marigold","uri":"https://rr1---sn-ipoxu-un5es.googlevideo.com/videoplayback?expire=1749730469&ei=RXBKaKW9E_icvcAPtsH0mA0&ip=114.32.69.88&id=o-ANpM6S6lPQfR0Gt20Q5is3it0wqnuQkoKxi48X-MLJr5&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749708869%2C&mh=s9&mm=31%2C29&mn=sn-ipoxu-un5es%2Csn-un57sn7y&ms=au%2Crdu&mv=m&mvi=1&pcm2cms=yes&pl=24&rms=au%2Cau&gcr=tw&initcwndbps=2713750&bui=AY1jyLN_qUsP4KnM2PISISvEyX-yjM-t59OSS_oqw08qLPIAH4uS-X2de4Blp9Zi4vCiH6rMy1XWu-mb&spc=l3OVKVNNvoqTI8X74NlpGABreY42F7tzffdBFcjl5bb1eRPrpWVBKPBp8-HuG2zHF2I&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=1kojuWY9rYvScC9GhIC83WUQ&rqh=1&gir=yes&clen=5241952&dur=306.641&lmt=1714656050082314&mt=1749708540&fvip=4&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5532434&n=xAMfXvYG_VCrAg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgJzelmoeDbJm5M45Hdbnzvt2NQ2ZzStx_L3ElUN0nN24CIQCeqFS_DM3ZKCyZp07-k1C4dnBP4y8i9i2IfZFWrz1L6w%3D%3D&sig=AJfQdSswRQIgERKfypJ44L8QxqeknzM8lnGXgBXbz2XbDULRHig9YBACIQDI06aRiPWICImTHD9tVjY9bt-HWVQ7Liox8LqrUXRDQQ%3D%3D&pot=MniWGCaUtWEyGpYkj-UvL5szblut_IR_0Erefe1rx_ptQ_g-Y6BPRPoj4eA93pD4BNIVrxyqN5ohAAyAIR-FUPK1xR8AOCzUschrvhF5mcoZ1J1BhdZQRnOHC2pzd3mWLO1_BRRs7oe3YiadsUe5FPGFQE2joM1DHGQ%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 12 14:14:32 macaca-volumio volumio[1257]: verbose: CURRENT POSITION 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::syncState stateService play Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::syncState currentStatus play Jun 12 14:14:32 macaca-volumio volumio[1257]: info: Received an update from plugin. extracting info from payload Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreStateMachine::pushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Jun 12 14:14:32 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 22 Jun 12 14:14:32 macaca-volumio volumio[1257]: info: ------------------------------ 31ms Jun 12 14:14:32 macaca-volumio volumio[1257]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Jun 12 14:14:32 macaca-volumio volumio[1257]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Jun 12 14:14:32 macaca-volumio volumio[1257]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Jun 12 14:14:32 macaca-volumio volumio[1257]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Jun 12 14:14:32 macaca-volumio volumio[1257]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Jun 12 14:14:32 macaca-volumio volumio[1257]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Jun 12 14:14:33 macaca-volumio volumio[1257]: info: CoreStateMachine::startPlaybackTimer Jun 12 14:14:33 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 23 Jun 12 14:14:34 macaca-volumio volumio[1257]: info: CoreStateMachine::pushState Jun 12 14:14:34 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 23 Jun 12 14:14:34 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 14:14:34 macaca-volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Jun 12 14:14:34 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 23 Jun 12 14:14:34 macaca-volumio volumio[1257]: info: CorePlayQueue::getTrack 23 Jun 12 14:14:34 macaca-volumio volumio[1257]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Jun 12 14:14:43 macaca-volumio wpa_supplicant[1107]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 12 14:14:51 macaca-volumio wpa_supplicant[1107]: wlan0: CTRL-EVENT-BEACON-LOSS Jun 12 14:14:51 macaca-volumio volumio[1257]: Searching all installed plugins Jun 12 14:14:51 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 12 14:14:51 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: , search Jun 12 14:14:51 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 12 14:14:51 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jun 12 14:14:51 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jun 12 14:14:51 macaca-volumio volumio[1257]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jun 12 14:14:51 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 12 14:14:51 macaca-volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jun 12 14:14:52 macaca-volumio volumio[1257]: Use XMLElement.setAttribute instead Jun 12 14:14:52 macaca-volumio volumio[1257]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 12 14:14:52 macaca-volumio volumio[1257]: TypeError: children[i].attr(...).value is not a function Jun 12 14:14:52 macaca-volumio volumio[1257]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 12 14:14:52 macaca-volumio volumio[1257]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 12 14:14:52 macaca-volumio volumio[1257]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 12 14:14:52 macaca-volumio sudo[282682]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-12 14:13' Jun 12 14:14:52 macaca-volumio sudo[282682]: 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"