Dec 16 16:22:21 volumio volumio[28139]: Searching plugin music_service/youtube2 Dec 16 16:22:21 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Dec 16 16:22:21 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Dec 16 16:22:21 volumio dbus-daemon[552]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.487' (uid=0 pid=6621 comm="timedatectl show --property=NTPSynchronized --valu") Dec 16 16:22:21 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Dec 16 16:22:22 volumio dbus-daemon[552]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 16 16:22:22 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Dec 16 16:22:22 volumio setdatetime-helper.sh[6620]: Time is already synchronized. Dec 16 16:22:22 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Dec 16 16:22:22 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Dec 16 16:22:22 volumio volumio[28139]: Searching plugin music_service/youtube2 Dec 16 16:22:22 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Dec 16 16:22:22 volumio volumio[28139]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 16 16:22:22 volumio volumio[28139]: command_run: { startIndex: 0, length: 57, onTap: { innertubeCommand: [Object] } }, Dec 16 16:22:22 volumio volumio[28139]: input_data: { Dec 16 16:22:22 volumio volumio[28139]: content: 'Vanilla Ice - Ice Ice Baby (Official Music Video) · 3:58', Dec 16 16:22:22 volumio volumio[28139]: commandRuns: [ [Object] ] Dec 16 16:22:22 volumio volumio[28139]: }, Dec 16 16:22:22 volumio volumio[28139]: parsed_runs: [ Dec 16 16:22:22 volumio volumio[28139]: { Dec 16 16:22:22 volumio volumio[28139]: text: 'Vanilla Ice - Ice Ice Baby (Official Music Video) · 3:58', Dec 16 16:22:22 volumio volumio[28139]: startIndex: 0 Dec 16 16:22:22 volumio volumio[28139]: } Dec 16 16:22:22 volumio volumio[28139]: ] Dec 16 16:22:22 volumio volumio[28139]: } Dec 16 16:22:22 volumio volumio[28139]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 16 16:22:22 volumio volumio[28139]: command_run: { startIndex: 0, length: 61, onTap: { innertubeCommand: [Object] } }, Dec 16 16:22:22 volumio volumio[28139]: input_data: { Dec 16 16:22:22 volumio volumio[28139]: content: 'Technotronic - Pump Up The Jam (Official Music Video) · 3:42', Dec 16 16:22:22 volumio volumio[28139]: commandRuns: [ [Object] ] Dec 16 16:22:22 volumio volumio[28139]: }, Dec 16 16:22:22 volumio volumio[28139]: parsed_runs: [ Dec 16 16:22:22 volumio volumio[28139]: { Dec 16 16:22:22 volumio volumio[28139]: text: 'Technotronic - Pump Up The Jam (Official Music Video) · 3:42', Dec 16 16:22:22 volumio volumio[28139]: startIndex: 0 Dec 16 16:22:22 volumio volumio[28139]: } Dec 16 16:22:22 volumio volumio[28139]: ] Dec 16 16:22:22 volumio volumio[28139]: } Dec 16 16:22:22 volumio volumio[28139]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 16 16:22:22 volumio volumio[28139]: command_run: { startIndex: 0, length: 15, onTap: { innertubeCommand: [Object] } }, Dec 16 16:22:22 volumio volumio[28139]: input_data: { content: 'ICE ICE · 4:13', commandRuns: [ [Object] ] }, Dec 16 16:22:22 volumio volumio[28139]: parsed_runs: [ { text: 'ICE ICE · 4:13', startIndex: 0 } ] Dec 16 16:22:22 volumio volumio[28139]: } Dec 16 16:22:22 volumio volumio[28139]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 16 16:22:22 volumio volumio[28139]: command_run: { startIndex: 0, length: 17, onTap: { innertubeCommand: [Object] } }, Dec 16 16:22:22 volumio volumio[28139]: input_data: { content: 'KODAK BLU · 3:10', commandRuns: [ [Object] ] }, Dec 16 16:22:22 volumio volumio[28139]: parsed_runs: [ { text: 'KODAK BLU · 3:10', startIndex: 0 } ] Dec 16 16:22:22 volumio volumio[28139]: } Dec 16 16:22:22 volumio volumio[28139]: info: All search sources collected, pushing search results Dec 16 16:22:23 volumio volumio[28139]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 16 16:22:23 volumio volumio[28139]: command_run: { startIndex: 0, length: 57, onTap: { innertubeCommand: [Object] } }, Dec 16 16:22:23 volumio volumio[28139]: input_data: { Dec 16 16:22:23 volumio volumio[28139]: content: 'Vanilla Ice - Ice Ice Baby (Official Music Video) · 3:58', Dec 16 16:22:23 volumio volumio[28139]: commandRuns: [ [Object] ] Dec 16 16:22:23 volumio volumio[28139]: }, Dec 16 16:22:23 volumio volumio[28139]: parsed_runs: [ Dec 16 16:22:23 volumio volumio[28139]: { Dec 16 16:22:23 volumio volumio[28139]: text: 'Vanilla Ice - Ice Ice Baby (Official Music Video) · 3:58', Dec 16 16:22:23 volumio volumio[28139]: startIndex: 0 Dec 16 16:22:23 volumio volumio[28139]: } Dec 16 16:22:23 volumio volumio[28139]: ] Dec 16 16:22:23 volumio volumio[28139]: } Dec 16 16:22:23 volumio volumio[28139]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 16 16:22:23 volumio volumio[28139]: command_run: { startIndex: 0, length: 40, onTap: { innertubeCommand: [Object] } }, Dec 16 16:22:23 volumio volumio[28139]: input_data: { Dec 16 16:22:23 volumio volumio[28139]: content: "M.C. Hammer - U Can't Touch This · 4:34", Dec 16 16:22:23 volumio volumio[28139]: commandRuns: [ [Object] ] Dec 16 16:22:23 volumio volumio[28139]: }, Dec 16 16:22:23 volumio volumio[28139]: parsed_runs: [ Dec 16 16:22:23 volumio volumio[28139]: { text: "M.C. Hammer - U Can't Touch This · 4:34", startIndex: 0 } Dec 16 16:22:23 volumio volumio[28139]: ] Dec 16 16:22:23 volumio volumio[28139]: } Dec 16 16:22:23 volumio volumio[28139]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 16 16:22:23 volumio volumio[28139]: command_run: { startIndex: 0, length: 15, onTap: { innertubeCommand: [Object] } }, Dec 16 16:22:23 volumio volumio[28139]: input_data: { content: 'ICE ICE · 4:13', commandRuns: [ [Object] ] }, Dec 16 16:22:23 volumio volumio[28139]: parsed_runs: [ { text: 'ICE ICE · 4:13', startIndex: 0 } ] Dec 16 16:22:23 volumio volumio[28139]: } Dec 16 16:22:23 volumio volumio[28139]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 16 16:22:23 volumio volumio[28139]: command_run: { startIndex: 0, length: 17, onTap: { innertubeCommand: [Object] } }, Dec 16 16:22:23 volumio volumio[28139]: input_data: { content: 'KODAK BLU · 3:10', commandRuns: [ [Object] ] }, Dec 16 16:22:23 volumio volumio[28139]: parsed_runs: [ { text: 'KODAK BLU · 3:10', startIndex: 0 } ] Dec 16 16:22:23 volumio volumio[28139]: } Dec 16 16:22:23 volumio volumio[28139]: info: All search sources collected, pushing search results Dec 16 16:22:25 volumio volumio[28139]: info: Preload queue cleared Dec 16 16:22:25 volumio volumio[28139]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::ClearQueue Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::stop Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 16 16:22:25 volumio volumio[28139]: info: CorePlayQueue::clearPlayQueue Dec 16 16:22:25 volumio volumio[28139]: info: CorePlayQueue::saveQueue Dec 16 16:22:25 volumio volumio[28139]: info: CoreCommandRouter::volumioPushQueue Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::addQueueItems Dec 16 16:22:25 volumio volumio[28139]: info: CorePlayQueue::addQueueItems Dec 16 16:22:25 volumio volumio[28139]: info: Preload queue cleared Dec 16 16:22:25 volumio volumio[28139]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Vanilla%20Ice%20-%20Ice%20Ice%20Baby%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22Vanilla%20Ice%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Frog8ou-ZepE%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNAFEJQDSFryq4qpAwkIARUAAIhCGAE%3D%26rs%3DAOn4CLBtHVo4KKYzC6xaxJVl20PlAIB2yg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22rog8ou-ZepE%22%2C%22playlistId%22%3A%22RDrog8ou-ZepE%22%2C%22params%22%3A%22OAHAAQGqAwxJY2UgaWNlIGJhYnm6AwoIkvfaxIXmxYFFugMPEg1SRHJvZzhvdS1aZXBFugMKCLaX34_2opT9ZroDJBIiUExwMEUzdDlYZ3hadTZNYm5pdVljVmlPYUFnNmRKSnYwVLoDCwjdjZ_hsbO62eoBugMKCLK-9OO1sJyIcroDCgj6teyezqS7_i-6AwsI2IzQ59SKoJSZAboDCwijsemXgZjChYUBugMLCPnRxMmVod_m8wG6AwoI38GwsfGY8pZgugMKCObjwdm_vcSwCroDCgiP57D33sDS7X26AwoI26_xuYK5-pMJugMLCNXloaXQq-LfvwG6AwsI9cKM-dj__9iaAboDCgj2if_H5L_8jwi6AwoI9LS8t5i47PElugMKCKvwhpymwJ-1SvIDBQ0BPio9uAUB%22%7D%7D%7D Dec 16 16:22:25 volumio volumio[28139]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Vanilla%20Ice%20-%20Ice%20Ice%20Baby%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22Vanilla%20Ice%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Frog8ou-ZepE%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNAFEJQDSFryq4qpAwkIARUAAIhCGAE%3D%26rs%3DAOn4CLBtHVo4KKYzC6xaxJVl20PlAIB2yg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22rog8ou-ZepE%22%2C%22playlistId%22%3A%22RDrog8ou-ZepE%22%2C%22params%22%3A%22OAHAAQGqAwxJY2UgaWNlIGJhYnm6AwoIkvfaxIXmxYFFugMPEg1SRHJvZzhvdS1aZXBFugMKCLaX34_2opT9ZroDJBIiUExwMEUzdDlYZ3hadTZNYm5pdVljVmlPYUFnNmRKSnYwVLoDCwjdjZ_hsbO62eoBugMKCLK-9OO1sJyIcroDCgj6teyezqS7_i-6AwsI2IzQ59SKoJSZAboDCwijsemXgZjChYUBugMLCPnRxMmVod_m8wG6AwoI38GwsfGY8pZgugMKCObjwdm_vcSwCroDCgiP57D33sDS7X26AwoI26_xuYK5-pMJugMLCNXloaXQq-LfvwG6AwsI9cKM-dj__9iaAboDCgj2if_H5L_8jwi6AwoI9LS8t5i47PElugMKCKvwhpymwJ-1SvIDBQ0BPio9uAUB%22%7D%7D%7D in service youtube2 Dec 16 16:22:25 volumio volumio[28139]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Vanilla%20Ice%20-%20Ice%20Ice%20Baby%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22Vanilla%20Ice%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Frog8ou-ZepE%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNAFEJQDSFryq4qpAwkIARUAAIhCGAE%3D%26rs%3DAOn4CLBtHVo4KKYzC6xaxJVl20PlAIB2yg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22rog8ou-ZepE%22%2C%22playlistId%22%3A%22RDrog8ou-ZepE%22%2C%22params%22%3A%22OAHAAQGqAwxJY2UgaWNlIGJhYnm6AwoIkvfaxIXmxYFFugMPEg1SRHJvZzhvdS1aZXBFugMKCLaX34_2opT9ZroDJBIiUExwMEUzdDlYZ3hadTZNYm5pdVljVmlPYUFnNmRKSnYwVLoDCwjdjZ_hsbO62eoBugMKCLK-9OO1sJyIcroDCgj6teyezqS7_i-6AwsI2IzQ59SKoJSZAboDCwijsemXgZjChYUBugMLCPnRxMmVod_m8wG6AwoI38GwsfGY8pZgugMKCObjwdm_vcSwCroDCgiP57D33sDS7X26AwoI26_xuYK5-pMJugMLCNXloaXQq-LfvwG6AwsI9cKM-dj__9iaAboDCgj2if_H5L_8jwi6AwoI9LS8t5i47PElugMKCKvwhpymwJ-1SvIDBQ0BPio9uAUB%22%7D%7D%7D Dec 16 16:22:25 volumio volumio[28139]: info: CoreCommandRouter::volumioPushQueue Dec 16 16:22:25 volumio volumio[28139]: info: CorePlayQueue::saveQueue Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::updateTrackBlock Dec 16 16:22:25 volumio volumio[28139]: info: CorePlayQueue::getTrackBlock Dec 16 16:22:25 volumio volumio[28139]: info: CoreCommandRouter::volumioPlay Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::play index 0 Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::stop Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::play index undefined Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 16 16:22:25 volumio volumio[28139]: info: CorePlayQueue::getTrack 0 Dec 16 16:22:25 volumio volumio[28139]: info: CoreStateMachine::startPlaybackTimer Dec 16 16:22:25 volumio volumio[28139]: info: CorePlayQueue::getTrack 0 Dec 16 16:22:25 volumio volumio[28139]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22rog8ou-ZepE%22%2C%22playlistId%22%3A%22RDrog8ou-ZepE%22%2C%22params%22%3A%22OAHAAQGqAwxJY2UgaWNlIGJhYnm6AwoIkvfaxIXmxYFFugMPEg1SRHJvZzhvdS1aZXBFugMKCLaX34_2opT9ZroDJBIiUExwMEUzdDlYZ3hadTZNYm5pdVljVmlPYUFnNmRKSnYwVLoDCwjdjZ_hsbO62eoBugMKCLK-9OO1sJyIcroDCgj6teyezqS7_i-6AwsI2IzQ59SKoJSZAboDCwijsemXgZjChYUBugMLCPnRxMmVod_m8wG6AwoI38GwsfGY8pZgugMKCObjwdm_vcSwCroDCgiP57D33sDS7X26AwoI26_xuYK5-pMJugMLCNXloaXQq-LfvwG6AwsI9cKM-dj__9iaAboDCgj2if_H5L_8jwi6AwoI9LS8t5i47PElugMKCKvwhpymwJ-1SvIDBQ0BPio9uAUB%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Vanilla%20Ice%20-%20Ice%20Ice%20Baby%20(Official%20Music%20Video)%22%2C%22artist%22%3A%22Vanilla%20Ice%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Frog8ou-ZepE%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNAFEJQDSFryq4qpAwkIARUAAIhCGAE%3D%26rs%3DAOn4CLBtHVo4KKYzC6xaxJVl20PlAIB2yg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22rog8ou-ZepE%22%2C%22playlistId%22%3A%22RDrog8ou-ZepE%22%2C%22params%22%3A%22OAHAAQGqAwxJY2UgaWNlIGJhYnm6AwoIkvfaxIXmxYFFugMPEg1SRHJvZzhvdS1aZXBFugMKCLaX34_2opT9ZroDJBIiUExwMEUzdDlYZ3hadTZNYm5pdVljVmlPYUFnNmRKSnYwVLoDCwjdjZ_hsbO62eoBugMKCLK-9OO1sJyIcroDCgj6teyezqS7_i-6AwsI2IzQ59SKoJSZAboDCwijsemXgZjChYUBugMLCPnRxMmVod_m8wG6AwoI38GwsfGY8pZgugMKCObjwdm_vcSwCroDCgiP57D33sDS7X26AwoI26_xuYK5-pMJugMLCNXloaXQq-LfvwG6AwsI9cKM-dj__9iaAboDCgj2if_H5L_8jwi6AwoI9LS8t5i47PElugMKCKvwhpymwJ-1SvIDBQ0BPio9uAUB%22%7D%7D%7D Dec 16 16:22:25 volumio volumio[28139]: info: [ytmusic] Obtained PO token for video #rog8ou-ZepE: MlVzTYdEA0jTenNzhG9ke60UHkYQFXD7-LQAWmnnckgfcvIre72suMVmin0F5k3p7yX8E-JAPN4X2O59Tm_bhBIMHj2GgI8xN0fsRMpROR8wX5GOBR8R Dec 16 16:22:25 volumio volumio[28139]: info: [ytmusic] Obtained PO token for video #rog8ou-ZepE: MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX Dec 16 16:22:26 volumio volumio[28139]: info: [youtube2] VideoModel.getInfo(rog8ou-ZepE): validating stream URL "https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00"... Dec 16 16:22:26 volumio volumio[28139]: info: [youtube2] VideoModel.getInfo(rog8ou-ZepE): stream validated in 0.075s. Dec 16 16:22:26 volumio volumio[28139]: info: [youtube2] (AutoplayManager) Enabled Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand stop Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand stop took 2 milliseconds Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand clear Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand clear took 1 milliseconds Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00&t.YouTube" Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: error: updateQueue error: null Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 3ms Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand addid "https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00&t.YouTube" took 3 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 3ms Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 2ms Dec 16 16:22:26 volumio volumio[28139]: verbose: MPD COMMAND [object Object] Dec 16 16:22:26 volumio volumio[28139]: verbose: MPD COMMAND [object Object] Dec 16 16:22:26 volumio volumio[28139]: verbose: MPD COMMAND [object Object] Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 4ms Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 3ms Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 2ms Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand play Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces system playlist update Dec 16 16:22:26 volumio volumio[28139]: info: Ignoring MPD Status Update Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 7ms Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand play took 5 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 5ms Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 3ms Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces state update: player Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::getState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand status Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces state update: player Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::getState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand status Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces state update: player Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::getState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand status Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand status took 5 milliseconds Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces state update: player Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::getState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand status Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces state update: player Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::getState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand status Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand status took 6 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand status took 5 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand status took 3 milliseconds Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseTrackInfo Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::servicePushState Dec 16 16:22:26 volumio volumio[28139]: info: CorePlayQueue::getTrack 0 Dec 16 16:22:26 volumio volumio[28139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vanilla Ice - Ice Ice Baby (Official Music Video)","artist":"vanillaiceVEVO","album":"YouTube","uri":"https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 16 16:22:26 volumio volumio[28139]: verbose: CURRENT POSITION 0 Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState stateService play Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState currentStatus stop Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 15ms Dec 16 16:22:26 volumio volumio[28139]: info: Dec 16 16:22:26 volumio volumio[28139]: ---------------------------- MPD announces state update: player Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::getState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand status Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand status took 7 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand status took 2 milliseconds Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseTrackInfo Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseTrackInfo Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseTrackInfo Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseState Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::servicePushState Dec 16 16:22:26 volumio volumio[28139]: info: CorePlayQueue::getTrack 0 Dec 16 16:22:26 volumio volumio[28139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vanilla Ice - Ice Ice Baby (Official Music Video)","artist":"vanillaiceVEVO","album":"YouTube","uri":"https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 16 16:22:26 volumio volumio[28139]: verbose: CURRENT POSITION 0 Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState stateService play Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState currentStatus play Dec 16 16:22:26 volumio volumio[28139]: info: Received an update from plugin. extracting info from payload Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: [youtube2] (AutoplayManager) Added mpdStateListener Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::servicePushState Dec 16 16:22:26 volumio volumio[28139]: info: CorePlayQueue::getTrack 0 Dec 16 16:22:26 volumio volumio[28139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vanilla Ice - Ice Ice Baby (Official Music Video)","artist":"vanillaiceVEVO","album":"YouTube","uri":"https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 16 16:22:26 volumio volumio[28139]: verbose: CURRENT POSITION 0 Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState stateService play Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState currentStatus play Dec 16 16:22:26 volumio volumio[28139]: info: Received an update from plugin. extracting info from payload Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::servicePushState Dec 16 16:22:26 volumio volumio[28139]: info: CorePlayQueue::getTrack 0 Dec 16 16:22:26 volumio volumio[28139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vanilla Ice - Ice Ice Baby (Official Music Video)","artist":"vanillaiceVEVO","album":"YouTube","uri":"https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 16 16:22:26 volumio volumio[28139]: verbose: CURRENT POSITION 0 Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState stateService play Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState currentStatus play Dec 16 16:22:26 volumio volumio[28139]: info: Received an update from plugin. extracting info from payload Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 34ms Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 33ms Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 29ms Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 16 16:22:26 volumio volumio[28139]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseTrackInfo Dec 16 16:22:26 volumio volumio[28139]: verbose: ControllerMpd::parseTrackInfo Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::servicePushState Dec 16 16:22:26 volumio volumio[28139]: info: CorePlayQueue::getTrack 0 Dec 16 16:22:26 volumio volumio[28139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vanilla Ice - Ice Ice Baby (Official Music Video)","artist":"vanillaiceVEVO","album":"YouTube","uri":"https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 16 16:22:26 volumio volumio[28139]: verbose: CURRENT POSITION 0 Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState stateService play Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState currentStatus play Dec 16 16:22:26 volumio volumio[28139]: info: Received an update from plugin. extracting info from payload Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: ControllerMpd::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::servicePushState Dec 16 16:22:26 volumio volumio[28139]: info: CorePlayQueue::getTrack 0 Dec 16 16:22:26 volumio volumio[28139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":237,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vanilla Ice - Ice Ice Baby (Official Music Video)","artist":"vanillaiceVEVO","album":"YouTube","uri":"https://rr3---sn-aigl6nzr.googlevideo.com/videoplayback?expire=1765923745&ei=QYdBaargL7r_p-oPoazOiQI&ip=185.180.185.112&id=o-AASacderYQ6ls-B3rcSgxv7W3FZCSs4qzcAg8M2MWFT3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=182&met=1765902145%2C&mh=ix&mm=31%2C26&mn=sn-aigl6nzr%2Csn-5hnednss&ms=au%2Conr&mv=m&mvi=3&pl=24&rms=au%2Cau&gcr=gb&initcwndbps=1711250&bui=AYUSA3Cwmstp8q1E942AFkbSWWiDXxx7TPUARqGe5hRgpMMtjfjBYLZP6CjinomiPSHRNk4kQwEVACvb&spc=wH4Qqw8RgSTFIxnD078MBjTWYcnVAmm9h5buDQzcGXgKpN4_ixMsiw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n1eu1l2YmQjWJ1qoz_gmIT4R&rqh=1&gir=yes&clen=3882303&dur=237.041&lmt=1750275612605085&mt=1765901678&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=Dx1BadyDykw_pQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgaGauD1jaH-1VEHKokYSNxDchpPrgWCFwGroaQvAMl3cCIG1dkkTdvll_0LMpZW5CrkoAgLTMOBFdevKQm9MqSRX2&sig=AJfQdSswRgIhALoDi2uCGp9nIdQyq66DOFvA8NJDIRMAJJIfKJDT1ejdAiEA5Uz0B-dGPhMgygYv5LqWk2sq73LaRM4IGwlss4UzO-c%3D&pot=MlWpY68WYPH5WqldrD0Hwoc0xGg4RxNC0pTadEG1EfE1UigFU-_PAe9GUFMttC5QxQUmPcoSX2c9-DRTZj24PTgsxBOu0uyIHWdX2U3RtxiQi95M-MgX&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 16 16:22:26 volumio volumio[28139]: verbose: CURRENT POSITION 0 Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState stateService play Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::syncState currentStatus play Dec 16 16:22:26 volumio volumio[28139]: info: Received an update from plugin. extracting info from payload Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreStateMachine::pushState Dec 16 16:22:26 volumio volumio[28139]: info: CoreCommandRouter::volumioPushState Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 42ms Dec 16 16:22:26 volumio volumio[28139]: info: ------------------------------ 36ms Dec 16 16:22:52 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Dec 16 16:23:05 volumio volumio[28139]: Searching all installed plugins Dec 16 16:23:05 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:23:05 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: , search Dec 16 16:23:05 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 16 16:23:05 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Dec 16 16:23:05 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Dec 16 16:23:05 volumio volumio[28139]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Dec 16 16:23:05 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: webradio , search Dec 16 16:23:05 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Dec 16 16:23:05 volumio volumio[28139]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Dec 16 16:23:09 volumio volumio[28139]: info: [ytmusic] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version Dec 16 16:23:09 volumio volumio[28139]: info: [ytmusic] Innertube support service: Start service with Node Dec 16 16:23:10 volumio volumio[28139]: Use XMLElement.setAttribute instead Dec 16 16:23:10 volumio volumio[28139]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 16:23:10 volumio volumio[28139]: TypeError: children[i].attr(...).value is not a function Dec 16 16:23:10 volumio volumio[28139]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Dec 16 16:23:10 volumio volumio[28139]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 16 16:23:10 volumio volumio[28139]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 16:23:10 volumio sudo[6766]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-16 16:22' Dec 16 16:23:10 volumio sudo[6766]: 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="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 23 08:02:06 UTC 2025" VOLUMIO_VERSION="0.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="76fa67e30b28261e1dc7c3a89e610b9e"