Jun 04 18:06:11 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 04 18:06:11 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 04 18:06:11 player3b volumio[1073]: info: Discovery: Getting this device information Jun 04 18:06:11 player3b volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 04 18:06:11 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 04 18:06:13 player3b volumio[1073]: info: CoreCommandRouter::volumioGetVisibleSources Jun 04 18:06:13 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 18:06:26 player3b systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 04 18:06:26 player3b dbus-daemon[526]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.450' (uid=0 pid=31254 comm="timedatectl show --property=NTPSynchronized --valu") Jun 04 18:06:26 player3b systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 04 18:06:27 player3b dbus-daemon[526]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 04 18:06:27 player3b systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 04 18:06:27 player3b setdatetime-helper.sh[31253]: Time is already synchronized. Jun 04 18:06:27 player3b systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 04 18:06:27 player3b systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 04 18:06:40 player3b volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 04 18:06:40 player3b volumio[1073]: info: CoreStateMachine::getQueue Jun 04 18:06:40 player3b volumio[1073]: info: CorePlayQueue::getQueue Jun 04 18:06:41 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 04 18:06:41 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 04 18:06:41 player3b volumio[1073]: info: Discovery: Getting this device information Jun 04 18:06:41 player3b volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 04 18:06:41 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::volumioPlay Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::play index 0 Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::stop Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::stPlaybackTimer Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::updateTrackBlock Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrackBlock Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 2 Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::serviceStop Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 2 Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::serviceStop Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 04 18:06:52 player3b volumio[1073]: info: ControllerMpd::stop Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Jun 04 18:06:52 player3b volumio[1073]: info: Jun 04 18:06:52 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:52 player3b volumio[1073]: info: sendMpdCommand stop took 30 milliseconds Jun 04 18:06:52 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::play index undefined Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::startPlaybackTimer Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:52 player3b volumio[1073]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Awara%22%2C%22artist%22%3A%22Hariharan%22%2C%22album%22%3A%22Horizon%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2F8JrjuCSORbfmKYgEtuLC7B0LXUdhjLqMhkupC0Ia8Lii_71euq6Y7dknJxvxDk8ZjmcdTOpKCJtIx8lhZg%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hJOt9wH8uZQ%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hJOt9wH8uZQ%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D Jun 04 18:06:52 player3b volumio[1073]: info: Jun 04 18:06:52 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:52 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:52 player3b volumio[1073]: info: Jun 04 18:06:52 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:52 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:52 player3b volumio[1073]: info: sendMpdCommand status took 47 milliseconds Jun 04 18:06:52 player3b volumio[1073]: info: sendMpdCommand status took 6 milliseconds Jun 04 18:06:52 player3b volumio[1073]: info: sendMpdCommand status took 3 milliseconds Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:52 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 04 18:06:52 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 10 milliseconds Jun 04 18:06:52 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:52 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:52 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:52 player3b volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd Jun 04 18:06:52 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:52 player3b volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd Jun 04 18:06:52 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:52 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:52 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:52 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:52 player3b volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd Jun 04 18:06:52 player3b volumio[1073]: info: ------------------------------ 89ms Jun 04 18:06:52 player3b volumio[1073]: info: ------------------------------ 47ms Jun 04 18:06:52 player3b volumio[1073]: info: ------------------------------ 45ms Jun 04 18:06:54 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:54 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Jun 04 18:06:54 player3b volumio[1073]: info: sendMpdCommand stop took 4 milliseconds Jun 04 18:06:54 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand clear Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: info: sendMpdCommand clear took 3 milliseconds Jun 04 18:06:54 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-gwpa-jv3s.googlevideo.com/videoplayback?expire=1749062213&ei=5D1AaP2BOqTfssUPs4LE8QQ&ip=49.37.234.27&id=o-AL1Tw00oabkanxPX_JD8Jj8v7s01UNKBsamGped9Gyx_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749040612%2C&mh=rd&mm=31%2C29&mn=sn-gwpa-jv3s%2Csn-gwpa-h55e7&ms=au%2Crdu&mv=m&mvi=3&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=902500&hightc=yes&siu=1&bui=AY1jyLNgHJd3woeF2BbqYbuMnivy04_FoBCRT075C0lYyk7q7qjnYRcfu0-uCCXKX37U-_cqjw&spc=l3OVKTdqKWwAHWCHpdzQAGjDFylQO6UEDFAYGsGr8RjawkcxI5jP8sw-eGFGcdTovXnQX8Byrnec3Fc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ECHISjkYBYOBletFrIyLptwQ&rqh=1&gir=yes&clen=13908522&dur=382.861&lmt=1714771510905792&mt=1749040159&fvip=6&keepalive=yes&fexp=51466642&c=WEB_REMIX&sefc=1&txp=1318224&n=81bRhxMRhpr8mw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgF1oK7VFbAuFmvKVBNiyaH0VUua6hVKuVmXarnVJJpdQCIQDwZsSKSISM4GcMc2xmtWLbCec1VDgMVwQnmxTT8pLY2A%3D%3D&sig=AJfQdSswRQIhAL3LcvUFplTvP_y4Ss9-wk_UKpiwwfZ8Y1sXxsvhowsBAiBEQWIIaym0gqY7LCPEQr859SGAw7h14D_VMGhNDYX00Q%3D%3D&pot=Ml8TMecaBbrvgxMNXG3CoKf3p7Ok5V_MCna24fyioIQwJVRm9V01dgnP6BYZR-eHU7kqG10b31W58VD5KWh9-CMUoIXFJHb-WBMgd2XVgC0WXEEfQBacpyRKlba1BKA-DA%3D%3D&cver=1.20250219.01.00&t.YouTube" Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: error: updateQueue error: null Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 10ms Jun 04 18:06:54 player3b volumio[1073]: info: sendMpdCommand addid "https://rr3---sn-gwpa-jv3s.googlevideo.com/videoplayback?expire=1749062213&ei=5D1AaP2BOqTfssUPs4LE8QQ&ip=49.37.234.27&id=o-AL1Tw00oabkanxPX_JD8Jj8v7s01UNKBsamGped9Gyx_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749040612%2C&mh=rd&mm=31%2C29&mn=sn-gwpa-jv3s%2Csn-gwpa-h55e7&ms=au%2Crdu&mv=m&mvi=3&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=902500&hightc=yes&siu=1&bui=AY1jyLNgHJd3woeF2BbqYbuMnivy04_FoBCRT075C0lYyk7q7qjnYRcfu0-uCCXKX37U-_cqjw&spc=l3OVKTdqKWwAHWCHpdzQAGjDFylQO6UEDFAYGsGr8RjawkcxI5jP8sw-eGFGcdTovXnQX8Byrnec3Fc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ECHISjkYBYOBletFrIyLptwQ&rqh=1&gir=yes&clen=13908522&dur=382.861&lmt=1714771510905792&mt=1749040159&fvip=6&keepalive=yes&fexp=51466642&c=WEB_REMIX&sefc=1&txp=1318224&n=81bRhxMRhpr8mw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgF1oK7VFbAuFmvKVBNiyaH0VUua6hVKuVmXarnVJJpdQCIQDwZsSKSISM4GcMc2xmtWLbCec1VDgMVwQnmxTT8pLY2A%3D%3D&sig=AJfQdSswRQIhAL3LcvUFplTvP_y4Ss9-wk_UKpiwwfZ8Y1sXxsvhowsBAiBEQWIIaym0gqY7LCPEQr859SGAw7h14D_VMGhNDYX00Q%3D%3D&pot=Ml8TMecaBbrvgxMNXG3CoKf3p7Ok5V_MCna24fyioIQwJVRm9V01dgnP6BYZR-eHU7kqG10b31W58VD5KWh9-CMUoIXFJHb-WBMgd2XVgC0WXEEfQBacpyRKlba1BKA-DA%3D%3D&cver=1.20250219.01.00&t.YouTube" took 8 milliseconds Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 8ms Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 6ms Jun 04 18:06:54 player3b volumio[1073]: verbose: MPD COMMAND [object Object] Jun 04 18:06:54 player3b volumio[1073]: verbose: MPD COMMAND [object Object] Jun 04 18:06:54 player3b volumio[1073]: verbose: MPD COMMAND [object Object] Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 12ms Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 7ms Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 6ms Jun 04 18:06:54 player3b volumio[1073]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 04 18:06:54 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand play Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: info: Jun 04 18:06:54 player3b volumio[1073]: ---------------------------- MPD announces system playlist update Jun 04 18:06:54 player3b volumio[1073]: info: Ignoring MPD Status Update Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 11ms Jun 04 18:06:54 player3b volumio[1073]: info: sendMpdCommand play took 8 milliseconds Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 7ms Jun 04 18:06:54 player3b volumio[1073]: info: ------------------------------ 6ms Jun 04 18:06:55 player3b volumio[1073]: info: Jun 04 18:06:55 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:55 player3b volumio[1073]: info: Jun 04 18:06:55 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:55 player3b volumio[1073]: info: Jun 04 18:06:55 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:55 player3b volumio[1073]: info: Jun 04 18:06:55 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand status took 19 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand status took 18 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:55 player3b volumio[1073]: info: Jun 04 18:06:55 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:55 player3b volumio[1073]: info: Jun 04 18:06:55 player3b volumio[1073]: ---------------------------- MPD announces state update: player Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::getState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand status took 31 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand status took 29 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand status took 19 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand status took 16 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 17 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand status took 15 milliseconds Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:55 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:55 player3b volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":383,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Awara","artist":"Hariharan","album":"Horizon","uri":"https://rr3---sn-gwpa-jv3s.googlevideo.com/videoplayback?expire=1749062213&ei=5D1AaP2BOqTfssUPs4LE8QQ&ip=49.37.234.27&id=o-AL1Tw00oabkanxPX_JD8Jj8v7s01UNKBsamGped9Gyx_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749040612%2C&mh=rd&mm=31%2C29&mn=sn-gwpa-jv3s%2Csn-gwpa-h55e7&ms=au%2Crdu&mv=m&mvi=3&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=902500&hightc=yes&siu=1&bui=AY1jyLNgHJd3woeF2BbqYbuMnivy04_FoBCRT075C0lYyk7q7qjnYRcfu0-uCCXKX37U-_cqjw&spc=l3OVKTdqKWwAHWCHpdzQAGjDFylQO6UEDFAYGsGr8RjawkcxI5jP8sw-eGFGcdTovXnQX8Byrnec3Fc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ECHISjkYBYOBletFrIyLptwQ&rqh=1&gir=yes&clen=13908522&dur=382.861&lmt=1714771510905792&mt=1749040159&fvip=6&keepalive=yes&fexp=51466642&c=WEB_REMIX&sefc=1&txp=1318224&n=81bRhxMRhpr8mw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgF1oK7VFbAuFmvKVBNiyaH0VUua6hVKuVmXarnVJJpdQCIQDwZsSKSISM4GcMc2xmtWLbCec1VDgMVwQnmxTT8pLY2A%3D%3D&sig=AJfQdSswRQIhAL3LcvUFplTvP_y4Ss9-wk_UKpiwwfZ8Y1sXxsvhowsBAiBEQWIIaym0gqY7LCPEQr859SGAw7h14D_VMGhNDYX00Q%3D%3D&pot=Ml8TMecaBbrvgxMNXG3CoKf3p7Ok5V_MCna24fyioIQwJVRm9V01dgnP6BYZR-eHU7kqG10b31W58VD5KWh9-CMUoIXFJHb-WBMgd2XVgC0WXEEfQBacpyRKlba1BKA-DA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 04 18:06:55 player3b volumio[1073]: verbose: CURRENT POSITION 0 Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:55 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:55 player3b volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":383,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Awara","artist":"Hariharan","album":"Horizon","uri":"https://rr3---sn-gwpa-jv3s.googlevideo.com/videoplayback?expire=1749062213&ei=5D1AaP2BOqTfssUPs4LE8QQ&ip=49.37.234.27&id=o-AL1Tw00oabkanxPX_JD8Jj8v7s01UNKBsamGped9Gyx_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749040612%2C&mh=rd&mm=31%2C29&mn=sn-gwpa-jv3s%2Csn-gwpa-h55e7&ms=au%2Crdu&mv=m&mvi=3&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=902500&hightc=yes&siu=1&bui=AY1jyLNgHJd3woeF2BbqYbuMnivy04_FoBCRT075C0lYyk7q7qjnYRcfu0-uCCXKX37U-_cqjw&spc=l3OVKTdqKWwAHWCHpdzQAGjDFylQO6UEDFAYGsGr8RjawkcxI5jP8sw-eGFGcdTovXnQX8Byrnec3Fc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ECHISjkYBYOBletFrIyLptwQ&rqh=1&gir=yes&clen=13908522&dur=382.861&lmt=1714771510905792&mt=1749040159&fvip=6&keepalive=yes&fexp=51466642&c=WEB_REMIX&sefc=1&txp=1318224&n=81bRhxMRhpr8mw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgF1oK7VFbAuFmvKVBNiyaH0VUua6hVKuVmXarnVJJpdQCIQDwZsSKSISM4GcMc2xmtWLbCec1VDgMVwQnmxTT8pLY2A%3D%3D&sig=AJfQdSswRQIhAL3LcvUFplTvP_y4Ss9-wk_UKpiwwfZ8Y1sXxsvhowsBAiBEQWIIaym0gqY7LCPEQr859SGAw7h14D_VMGhNDYX00Q%3D%3D&pot=Ml8TMecaBbrvgxMNXG3CoKf3p7Ok5V_MCna24fyioIQwJVRm9V01dgnP6BYZR-eHU7kqG10b31W58VD5KWh9-CMUoIXFJHb-WBMgd2XVgC0WXEEfQBacpyRKlba1BKA-DA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 04 18:06:55 player3b volumio[1073]: verbose: CURRENT POSITION 0 Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 04 18:06:55 player3b volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: ------------------------------ 70ms Jun 04 18:06:55 player3b volumio[1073]: info: ------------------------------ 77ms Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand status took 60 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 48 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 48 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 48 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 48 milliseconds Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 46 milliseconds Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseState Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:55 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:55 player3b volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":383,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Awara","artist":"Hariharan","album":"Horizon","uri":"https://rr3---sn-gwpa-jv3s.googlevideo.com/videoplayback?expire=1749062213&ei=5D1AaP2BOqTfssUPs4LE8QQ&ip=49.37.234.27&id=o-AL1Tw00oabkanxPX_JD8Jj8v7s01UNKBsamGped9Gyx_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749040612%2C&mh=rd&mm=31%2C29&mn=sn-gwpa-jv3s%2Csn-gwpa-h55e7&ms=au%2Crdu&mv=m&mvi=3&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=902500&hightc=yes&siu=1&bui=AY1jyLNgHJd3woeF2BbqYbuMnivy04_FoBCRT075C0lYyk7q7qjnYRcfu0-uCCXKX37U-_cqjw&spc=l3OVKTdqKWwAHWCHpdzQAGjDFylQO6UEDFAYGsGr8RjawkcxI5jP8sw-eGFGcdTovXnQX8Byrnec3Fc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ECHISjkYBYOBletFrIyLptwQ&rqh=1&gir=yes&clen=13908522&dur=382.861&lmt=1714771510905792&mt=1749040159&fvip=6&keepalive=yes&fexp=51466642&c=WEB_REMIX&sefc=1&txp=1318224&n=81bRhxMRhpr8mw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgF1oK7VFbAuFmvKVBNiyaH0VUua6hVKuVmXarnVJJpdQCIQDwZsSKSISM4GcMc2xmtWLbCec1VDgMVwQnmxTT8pLY2A%3D%3D&sig=AJfQdSswRQIhAL3LcvUFplTvP_y4Ss9-wk_UKpiwwfZ8Y1sXxsvhowsBAiBEQWIIaym0gqY7LCPEQr859SGAw7h14D_VMGhNDYX00Q%3D%3D&pot=Ml8TMecaBbrvgxMNXG3CoKf3p7Ok5V_MCna24fyioIQwJVRm9V01dgnP6BYZR-eHU7kqG10b31W58VD5KWh9-CMUoIXFJHb-WBMgd2XVgC0WXEEfQBacpyRKlba1BKA-DA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 04 18:06:55 player3b volumio[1073]: verbose: CURRENT POSITION 0 Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 04 18:06:55 player3b volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:55 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:55 player3b volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":383,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Awara","artist":"Hariharan","album":"Horizon","uri":"https://rr3---sn-gwpa-jv3s.googlevideo.com/videoplayback?expire=1749062213&ei=5D1AaP2BOqTfssUPs4LE8QQ&ip=49.37.234.27&id=o-AL1Tw00oabkanxPX_JD8Jj8v7s01UNKBsamGped9Gyx_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749040612%2C&mh=rd&mm=31%2C29&mn=sn-gwpa-jv3s%2Csn-gwpa-h55e7&ms=au%2Crdu&mv=m&mvi=3&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=902500&hightc=yes&siu=1&bui=AY1jyLNgHJd3woeF2BbqYbuMnivy04_FoBCRT075C0lYyk7q7qjnYRcfu0-uCCXKX37U-_cqjw&spc=l3OVKTdqKWwAHWCHpdzQAGjDFylQO6UEDFAYGsGr8RjawkcxI5jP8sw-eGFGcdTovXnQX8Byrnec3Fc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ECHISjkYBYOBletFrIyLptwQ&rqh=1&gir=yes&clen=13908522&dur=382.861&lmt=1714771510905792&mt=1749040159&fvip=6&keepalive=yes&fexp=51466642&c=WEB_REMIX&sefc=1&txp=1318224&n=81bRhxMRhpr8mw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgF1oK7VFbAuFmvKVBNiyaH0VUua6hVKuVmXarnVJJpdQCIQDwZsSKSISM4GcMc2xmtWLbCec1VDgMVwQnmxTT8pLY2A%3D%3D&sig=AJfQdSswRQIhAL3LcvUFplTvP_y4Ss9-wk_UKpiwwfZ8Y1sXxsvhowsBAiBEQWIIaym0gqY7LCPEQr859SGAw7h14D_VMGhNDYX00Q%3D%3D&pot=Ml8TMecaBbrvgxMNXG3CoKf3p7Ok5V_MCna24fyioIQwJVRm9V01dgnP6BYZR-eHU7kqG10b31W58VD5KWh9-CMUoIXFJHb-WBMgd2XVgC0WXEEfQBacpyRKlba1BKA-DA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 04 18:06:55 player3b volumio[1073]: verbose: CURRENT POSITION 0 Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 04 18:06:55 player3b volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:55 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:55 player3b volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":383,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Awara","artist":"Hariharan","album":"Horizon","uri":"https://rr3---sn-gwpa-jv3s.googlevideo.com/videoplayback?expire=1749062213&ei=5D1AaP2BOqTfssUPs4LE8QQ&ip=49.37.234.27&id=o-AL1Tw00oabkanxPX_JD8Jj8v7s01UNKBsamGped9Gyx_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749040612%2C&mh=rd&mm=31%2C29&mn=sn-gwpa-jv3s%2Csn-gwpa-h55e7&ms=au%2Crdu&mv=m&mvi=3&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=902500&hightc=yes&siu=1&bui=AY1jyLNgHJd3woeF2BbqYbuMnivy04_FoBCRT075C0lYyk7q7qjnYRcfu0-uCCXKX37U-_cqjw&spc=l3OVKTdqKWwAHWCHpdzQAGjDFylQO6UEDFAYGsGr8RjawkcxI5jP8sw-eGFGcdTovXnQX8Byrnec3Fc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ECHISjkYBYOBletFrIyLptwQ&rqh=1&gir=yes&clen=13908522&dur=382.861&lmt=1714771510905792&mt=1749040159&fvip=6&keepalive=yes&fexp=51466642&c=WEB_REMIX&sefc=1&txp=1318224&n=81bRhxMRhpr8mw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgF1oK7VFbAuFmvKVBNiyaH0VUua6hVKuVmXarnVJJpdQCIQDwZsSKSISM4GcMc2xmtWLbCec1VDgMVwQnmxTT8pLY2A%3D%3D&sig=AJfQdSswRQIhAL3LcvUFplTvP_y4Ss9-wk_UKpiwwfZ8Y1sXxsvhowsBAiBEQWIIaym0gqY7LCPEQr859SGAw7h14D_VMGhNDYX00Q%3D%3D&pot=Ml8TMecaBbrvgxMNXG3CoKf3p7Ok5V_MCna24fyioIQwJVRm9V01dgnP6BYZR-eHU7kqG10b31W58VD5KWh9-CMUoIXFJHb-WBMgd2XVgC0WXEEfQBacpyRKlba1BKA-DA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 04 18:06:55 player3b volumio[1073]: verbose: CURRENT POSITION 0 Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 04 18:06:55 player3b volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: ------------------------------ 147ms Jun 04 18:06:55 player3b volumio[1073]: info: ------------------------------ 136ms Jun 04 18:06:55 player3b volumio[1073]: info: ------------------------------ 132ms Jun 04 18:06:55 player3b volumio[1073]: info: sendMpdCommand playlistinfo took 102 milliseconds Jun 04 18:06:55 player3b volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 04 18:06:55 player3b volumio[1073]: info: ControllerMpd::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::servicePushState Jun 04 18:06:55 player3b volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 04 18:06:55 player3b volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":383,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Awara","artist":"Hariharan","album":"Horizon","uri":"https://rr3---sn-gwpa-jv3s.googlevideo.com/videoplayback?expire=1749062213&ei=5D1AaP2BOqTfssUPs4LE8QQ&ip=49.37.234.27&id=o-AL1Tw00oabkanxPX_JD8Jj8v7s01UNKBsamGped9Gyx_&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749040612%2C&mh=rd&mm=31%2C29&mn=sn-gwpa-jv3s%2Csn-gwpa-h55e7&ms=au%2Crdu&mv=m&mvi=3&pl=20&rms=au%2Cau&ctier=A&pfa=5&gcr=in&initcwndbps=902500&hightc=yes&siu=1&bui=AY1jyLNgHJd3woeF2BbqYbuMnivy04_FoBCRT075C0lYyk7q7qjnYRcfu0-uCCXKX37U-_cqjw&spc=l3OVKTdqKWwAHWCHpdzQAGjDFylQO6UEDFAYGsGr8RjawkcxI5jP8sw-eGFGcdTovXnQX8Byrnec3Fc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ECHISjkYBYOBletFrIyLptwQ&rqh=1&gir=yes&clen=13908522&dur=382.861&lmt=1714771510905792&mt=1749040159&fvip=6&keepalive=yes&fexp=51466642&c=WEB_REMIX&sefc=1&txp=1318224&n=81bRhxMRhpr8mw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgF1oK7VFbAuFmvKVBNiyaH0VUua6hVKuVmXarnVJJpdQCIQDwZsSKSISM4GcMc2xmtWLbCec1VDgMVwQnmxTT8pLY2A%3D%3D&sig=AJfQdSswRQIhAL3LcvUFplTvP_y4Ss9-wk_UKpiwwfZ8Y1sXxsvhowsBAiBEQWIIaym0gqY7LCPEQr859SGAw7h14D_VMGhNDYX00Q%3D%3D&pot=Ml8TMecaBbrvgxMNXG3CoKf3p7Ok5V_MCna24fyioIQwJVRm9V01dgnP6BYZR-eHU7kqG10b31W58VD5KWh9-CMUoIXFJHb-WBMgd2XVgC0WXEEfQBacpyRKlba1BKA-DA%3D%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Jun 04 18:06:55 player3b volumio[1073]: verbose: CURRENT POSITION 0 Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 04 18:06:55 player3b volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreStateMachine::pushState Jun 04 18:06:55 player3b volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 04 18:06:55 player3b volumio[1073]: info: ------------------------------ 197ms Jun 04 18:06:57 player3b systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 04 18:07:21 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 04 18:07:21 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 04 18:07:21 player3b volumio[1073]: info: Discovery: Getting this device information Jun 04 18:07:21 player3b volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 04 18:07:21 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 04 18:07:35 player3b volumio[1073]: Searching all installed plugins Jun 04 18:07:35 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 18:07:35 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: , search Jun 04 18:07:35 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 04 18:07:35 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jun 04 18:07:35 player3b volumio[1073]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jun 04 18:07:35 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 04 18:07:35 player3b volumio[1073]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jun 04 18:07:36 player3b volumio[1073]: Use XMLElement.setAttribute instead Jun 04 18:07:36 player3b volumio[1073]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 04 18:07:36 player3b volumio[1073]: TypeError: children[i].attr(...).value is not a function Jun 04 18:07:36 player3b volumio[1073]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 04 18:07:36 player3b volumio[1073]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 04 18:07:36 player3b volumio[1073]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 04 18:07:38 player3b sudo[31376]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-04 18:06' Jun 04 18:07:38 player3b sudo[31376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"