Jun 01 09:04:00 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:00 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand stop Jun 01 09:04:00 volumio volumio[1090]: info: sendMpdCommand stop took 21 milliseconds Jun 01 09:04:00 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand clear Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: info: sendMpdCommand clear took 16 milliseconds Jun 01 09:04:00 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand addid "https://rr4---sn-4g5e6nsd.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aJHTIdX9hcIP_NbZgQM&ip=46.223.28.163&id=o-AGJxM0fr5js30J2lCrw66m1U3tbqYX6DnJQIvieZ0XHA&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C26&mn=sn-4g5e6nsd%2Csn-h0jeln7l&ms=au%2Conr&mv=m&mvi=4&pl=20&rms=au%2Cau&initcwndbps=2498750&bui=AY1jyLMAWduQO8kSeSX1V9RaEo9R4U8FttlRtCPZTzETiSpHbkVV_JzevSBXDxwHcDzYRwlxERzRwp8O&spc=l3OVKbtTOvP_iARnAq-RGKBt7UOIgtA1dDbPWYdDaqnydQJjbVsbdSaAi98BR-oZyZA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n6DVkRdgT1HFBNkdRK9fx-8Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761008&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=QDq3KGpH8X8tnQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhANEcvbLXw8A_rpFW6IbpQJDY9xEzRyEfWlpCdzKvx4R_AiBPZVz6_uCr-FUzkUcZfQGkyBjXNmvqPwPqJR8XgzHBYQ%3D%3D&sig=AJfQdSswRAIgciTN4fs329kjseO_Z7zYGZW5Po1z6ymCz-chyYFDglECIHiZMz18rvLWr0rc96GpPQgqcaLoQ0LnoD6FbCDWLEaK&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube" Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: error: updateQueue error: null Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 50ms Jun 01 09:04:00 volumio volumio[1090]: info: sendMpdCommand addid "https://rr4---sn-4g5e6nsd.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aJHTIdX9hcIP_NbZgQM&ip=46.223.28.163&id=o-AGJxM0fr5js30J2lCrw66m1U3tbqYX6DnJQIvieZ0XHA&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C26&mn=sn-4g5e6nsd%2Csn-h0jeln7l&ms=au%2Conr&mv=m&mvi=4&pl=20&rms=au%2Cau&initcwndbps=2498750&bui=AY1jyLMAWduQO8kSeSX1V9RaEo9R4U8FttlRtCPZTzETiSpHbkVV_JzevSBXDxwHcDzYRwlxERzRwp8O&spc=l3OVKbtTOvP_iARnAq-RGKBt7UOIgtA1dDbPWYdDaqnydQJjbVsbdSaAi98BR-oZyZA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n6DVkRdgT1HFBNkdRK9fx-8Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761008&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=QDq3KGpH8X8tnQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhANEcvbLXw8A_rpFW6IbpQJDY9xEzRyEfWlpCdzKvx4R_AiBPZVz6_uCr-FUzkUcZfQGkyBjXNmvqPwPqJR8XgzHBYQ%3D%3D&sig=AJfQdSswRAIgciTN4fs329kjseO_Z7zYGZW5Po1z6ymCz-chyYFDglECIHiZMz18rvLWr0rc96GpPQgqcaLoQ0LnoD6FbCDWLEaK&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube" took 35 milliseconds Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 35ms Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 31ms Jun 01 09:04:00 volumio volumio[1090]: verbose: MPD COMMAND [object Object] Jun 01 09:04:00 volumio volumio[1090]: verbose: MPD COMMAND [object Object] Jun 01 09:04:00 volumio volumio[1090]: verbose: MPD COMMAND [object Object] Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 46ms Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 22ms Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 21ms Jun 01 09:04:00 volumio volumio[1090]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 01 09:04:00 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand play Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: info: Jun 01 09:04:00 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:00 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 31ms Jun 01 09:04:00 volumio volumio[1090]: info: sendMpdCommand play took 24 milliseconds Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 21ms Jun 01 09:04:00 volumio volumio[1090]: info: ------------------------------ 19ms Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand stop Jun 01 09:04:01 volumio mpd[1316]: player: played "https://rr4---sn-4g5e6nsd.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aJHTIdX9hcIP_NbZgQM&ip=46.223.28.163&id=o-AGJxM0fr5js30J2lCrw66m1U3tbqYX6DnJQIvieZ0XHA&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C26&mn=sn-4g5e6nsd%2Csn-h0jeln7l&ms=au%2Conr&mv=m&mvi=4&pl=20&rms=au%2Cau&initcwndbps=2498750&bui=AY1jyLMAWduQO8kSeSX1V9RaEo9R4U8FttlRtCPZTzETiSpHbkVV_JzevSBXDxwHcDzYRwlxERzRwp8O&spc=l3OVKbtTOvP_iARnAq-RGKBt7UOIgtA1dDbPWYdDaqnydQJjbVsbdSaAi98BR-oZyZA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=n6DVkRdgT1HFBNkdRK9fx-8Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761008&fvip=1&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=QDq3KGpH8X8tnQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhANEcvbLXw8A_rpFW6IbpQJDY9xEzRyEfWlpCdzKvx4R_AiBPZVz6_uCr-FUzkUcZfQGkyBjXNmvqPwPqJR8XgzHBYQ%3D%3D&sig=AJfQdSswRAIgciTN4fs329kjseO_Z7zYGZW5Po1z6ymCz-chyYFDglECIHiZMz18rvLWr0rc96GpPQgqcaLoQ0LnoD6FbCDWLEaK&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube" Jun 01 09:04:01 volumio volumio[1090]: info: Jun 01 09:04:01 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:01 volumio volumio[1090]: info: sendMpdCommand stop took 22 milliseconds Jun 01 09:04:01 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand clear Jun 01 09:04:01 volumio volumio[1090]: info: Jun 01 09:04:01 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:01 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:01 volumio volumio[1090]: info: sendMpdCommand status took 21 milliseconds Jun 01 09:04:01 volumio volumio[1090]: info: sendMpdCommand clear took 21 milliseconds Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-4g5edn6k.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aPveKoj3xN8P5vO5uAg&ip=46.223.28.163&id=o-AErSROHySLr_3dL94cXSWycqyMr8Xbb-7wTn7RHGSAyo&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C29&mn=sn-4g5edn6k%2Csn-4g5e6nsd&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&initcwndbps=2766250&bui=AY1jyLN-_awjcoaQgvIm0_MTdDlZJsqVPVxbuj0zzGUhxSBNpiRG1i_yQABWGmGBaJmG4IvSbw1bSjns&spc=l3OVKZz9xk7b0eEB_BGiYtfDbobNirCJah98C3P2bXL7VHhux-R9C-HDpMBt2LfAWgo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga32283lptzkiUTLTeoiSj4Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761260&fvip=4&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=uEsdeVyqfv4GNQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgVTHdD8TIyacHHXT4T-nnmbBvaultUreOs19GiZ30vbUCIHz5aluvBaWZ__H35GEgR6pqwLQ9QG4Qim1xFaDoWlxt&sig=AJfQdSswRQIhAMksY1bPaDeo7kaE4MjZCXN5zu-L-e88u2iW3BiKwxagAiA9S0qI96TRWGQbE9nxBjbXxhrLTcZ61UZ2eRdUar4-ng%3D%3D&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube" Jun 01 09:04:01 volumio volumio[1090]: info: Jun 01 09:04:01 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:01 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:01 volumio volumio[1090]: info: Jun 01 09:04:01 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:01 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:01 volumio volumio[1090]: error: updateQueue error: null Jun 01 09:04:01 volumio volumio[1090]: info: Jun 01 09:04:01 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:01 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:01 volumio volumio[1090]: info: ------------------------------ 62ms Jun 01 09:04:01 volumio volumio[1090]: info: sendMpdCommand playlistinfo took 45 milliseconds Jun 01 09:04:01 volumio volumio[1090]: info: sendMpdCommand addid "https://rr1---sn-4g5edn6k.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aPveKoj3xN8P5vO5uAg&ip=46.223.28.163&id=o-AErSROHySLr_3dL94cXSWycqyMr8Xbb-7wTn7RHGSAyo&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C29&mn=sn-4g5edn6k%2Csn-4g5e6nsd&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&initcwndbps=2766250&bui=AY1jyLN-_awjcoaQgvIm0_MTdDlZJsqVPVxbuj0zzGUhxSBNpiRG1i_yQABWGmGBaJmG4IvSbw1bSjns&spc=l3OVKZz9xk7b0eEB_BGiYtfDbobNirCJah98C3P2bXL7VHhux-R9C-HDpMBt2LfAWgo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga32283lptzkiUTLTeoiSj4Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761260&fvip=4&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=uEsdeVyqfv4GNQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgVTHdD8TIyacHHXT4T-nnmbBvaultUreOs19GiZ30vbUCIHz5aluvBaWZ__H35GEgR6pqwLQ9QG4Qim1xFaDoWlxt&sig=AJfQdSswRQIhAMksY1bPaDeo7kaE4MjZCXN5zu-L-e88u2iW3BiKwxagAiA9S0qI96TRWGQbE9nxBjbXxhrLTcZ61UZ2eRdUar4-ng%3D%3D&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube" took 45 milliseconds Jun 01 09:04:01 volumio volumio[1090]: info: sendMpdCommand status took 44 milliseconds Jun 01 09:04:01 volumio volumio[1090]: info: sendMpdCommand status took 75 milliseconds Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::parseTrackInfo Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:01 volumio volumio[1090]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 01 09:04:01 volumio volumio[1090]: verbose: MPD COMMAND [object Object] Jun 01 09:04:01 volumio volumio[1090]: verbose: MPD COMMAND [object Object] Jun 01 09:04:01 volumio volumio[1090]: verbose: MPD COMMAND [object Object] Jun 01 09:04:01 volumio volumio[1090]: info: ControllerMpd::pushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::servicePushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:01 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:01 volumio volumio[1090]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 09:04:01 volumio volumio[1090]: verbose: CURRENT POSITION 0 Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::syncState stateService stop Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::syncState currentStatus stop Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:01 volumio volumio[1090]: info: No code Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:01 volumio volumio[1090]: info: ControllerMpd::pushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::servicePushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:01 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:01 volumio volumio[1090]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 09:04:01 volumio volumio[1090]: verbose: CURRENT POSITION 0 Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::syncState stateService stop Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::syncState currentStatus stop Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:01 volumio volumio[1090]: info: No code Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:01 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:01 volumio volumio[1090]: info: ------------------------------ 232ms Jun 01 09:04:01 volumio volumio[1090]: info: ------------------------------ 333ms Jun 01 09:04:01 volumio volumio[1090]: info: ------------------------------ 332ms Jun 01 09:04:01 volumio volumio[1090]: info: Jun 01 09:04:01 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:01 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:01 volumio volumio[1090]: info: Jun 01 09:04:01 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:01 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:01 volumio volumio[1090]: info: Jun 01 09:04:01 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:01 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:01 volumio volumio[1090]: info: ------------------------------ 376ms Jun 01 09:04:01 volumio volumio[1090]: info: ------------------------------ 47ms Jun 01 09:04:01 volumio volumio[1090]: info: ------------------------------ 46ms Jun 01 09:04:01 volumio volumio[1090]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 01 09:04:01 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand play Jun 01 09:04:02 volumio volumio[1090]: info: Jun 01 09:04:02 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:02 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:02 volumio volumio[1090]: info: Jun 01 09:04:02 volumio volumio[1090]: ---------------------------- MPD announces system playlist update Jun 01 09:04:02 volumio volumio[1090]: info: Ignoring MPD Status Update Jun 01 09:04:02 volumio volumio[1090]: info: ------------------------------ 151ms Jun 01 09:04:02 volumio volumio[1090]: info: sendMpdCommand play took 148 milliseconds Jun 01 09:04:02 volumio volumio[1090]: info: ------------------------------ 126ms Jun 01 09:04:02 volumio volumio[1090]: info: ------------------------------ 124ms Jun 01 09:04:02 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:03 volumio mpd[1316]: ffmpeg/opus: Could not update timestamps for skipped samples. Jun 01 09:04:03 volumio volumio[1090]: info: Jun 01 09:04:03 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:03 volumio volumio[1090]: info: Jun 01 09:04:03 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:03 volumio volumio[1090]: info: Jun 01 09:04:03 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:03 volumio volumio[1090]: info: Jun 01 09:04:03 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand status took 5 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 09:04:03 volumio volumio[1090]: info: Jun 01 09:04:03 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:03 volumio volumio[1090]: info: Jun 01 09:04:03 volumio volumio[1090]: ---------------------------- MPD announces state update: player Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::getState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand status Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand status took 59 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand status took 57 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand status took 56 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand playlistinfo took 34 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand status took 28 milliseconds Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseTrackInfo Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::servicePushState Jun 01 09:04:03 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:03 volumio volumio[1090]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"\"Kashmir Main Tu Kanyakumari\" Chennai Express Full Video Song | Shahrukh Khan, Deepika Padukone","artist":"T-Series","album":"YouTube","uri":"https://rr1---sn-4g5edn6k.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aPveKoj3xN8P5vO5uAg&ip=46.223.28.163&id=o-AErSROHySLr_3dL94cXSWycqyMr8Xbb-7wTn7RHGSAyo&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C29&mn=sn-4g5edn6k%2Csn-4g5e6nsd&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&initcwndbps=2766250&bui=AY1jyLN-_awjcoaQgvIm0_MTdDlZJsqVPVxbuj0zzGUhxSBNpiRG1i_yQABWGmGBaJmG4IvSbw1bSjns&spc=l3OVKZz9xk7b0eEB_BGiYtfDbobNirCJah98C3P2bXL7VHhux-R9C-HDpMBt2LfAWgo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga32283lptzkiUTLTeoiSj4Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761260&fvip=4&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=uEsdeVyqfv4GNQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgVTHdD8TIyacHHXT4T-nnmbBvaultUreOs19GiZ30vbUCIHz5aluvBaWZ__H35GEgR6pqwLQ9QG4Qim1xFaDoWlxt&sig=AJfQdSswRQIhAMksY1bPaDeo7kaE4MjZCXN5zu-L-e88u2iW3BiKwxagAiA9S0qI96TRWGQbE9nxBjbXxhrLTcZ61UZ2eRdUar4-ng%3D%3D&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} Jun 01 09:04:03 volumio volumio[1090]: verbose: CURRENT POSITION 0 Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState stateService play Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState currentStatus stop Jun 01 09:04:03 volumio volumio[1090]: info: ------------------------------ 83ms Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand status took 34 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand playlistinfo took 29 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand playlistinfo took 30 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand playlistinfo took 29 milliseconds Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand playlistinfo took 29 milliseconds Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseState Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseTrackInfo Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseTrackInfo Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseTrackInfo Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseTrackInfo Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::servicePushState Jun 01 09:04:03 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:03 volumio volumio[1090]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"\"Kashmir Main Tu Kanyakumari\" Chennai Express Full Video Song | Shahrukh Khan, Deepika Padukone","artist":"T-Series","album":"YouTube","uri":"https://rr1---sn-4g5edn6k.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aPveKoj3xN8P5vO5uAg&ip=46.223.28.163&id=o-AErSROHySLr_3dL94cXSWycqyMr8Xbb-7wTn7RHGSAyo&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C29&mn=sn-4g5edn6k%2Csn-4g5e6nsd&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&initcwndbps=2766250&bui=AY1jyLN-_awjcoaQgvIm0_MTdDlZJsqVPVxbuj0zzGUhxSBNpiRG1i_yQABWGmGBaJmG4IvSbw1bSjns&spc=l3OVKZz9xk7b0eEB_BGiYtfDbobNirCJah98C3P2bXL7VHhux-R9C-HDpMBt2LfAWgo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga32283lptzkiUTLTeoiSj4Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761260&fvip=4&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=uEsdeVyqfv4GNQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgVTHdD8TIyacHHXT4T-nnmbBvaultUreOs19GiZ30vbUCIHz5aluvBaWZ__H35GEgR6pqwLQ9QG4Qim1xFaDoWlxt&sig=AJfQdSswRQIhAMksY1bPaDeo7kaE4MjZCXN5zu-L-e88u2iW3BiKwxagAiA9S0qI96TRWGQbE9nxBjbXxhrLTcZ61UZ2eRdUar4-ng%3D%3D&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} Jun 01 09:04:03 volumio volumio[1090]: verbose: CURRENT POSITION 0 Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState stateService play Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState currentStatus play Jun 01 09:04:03 volumio volumio[1090]: info: Received an update from plugin. extracting info from payload Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::servicePushState Jun 01 09:04:03 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:03 volumio volumio[1090]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"\"Kashmir Main Tu Kanyakumari\" Chennai Express Full Video Song | Shahrukh Khan, Deepika Padukone","artist":"T-Series","album":"YouTube","uri":"https://rr1---sn-4g5edn6k.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aPveKoj3xN8P5vO5uAg&ip=46.223.28.163&id=o-AErSROHySLr_3dL94cXSWycqyMr8Xbb-7wTn7RHGSAyo&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C29&mn=sn-4g5edn6k%2Csn-4g5e6nsd&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&initcwndbps=2766250&bui=AY1jyLN-_awjcoaQgvIm0_MTdDlZJsqVPVxbuj0zzGUhxSBNpiRG1i_yQABWGmGBaJmG4IvSbw1bSjns&spc=l3OVKZz9xk7b0eEB_BGiYtfDbobNirCJah98C3P2bXL7VHhux-R9C-HDpMBt2LfAWgo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga32283lptzkiUTLTeoiSj4Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761260&fvip=4&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=uEsdeVyqfv4GNQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgVTHdD8TIyacHHXT4T-nnmbBvaultUreOs19GiZ30vbUCIHz5aluvBaWZ__H35GEgR6pqwLQ9QG4Qim1xFaDoWlxt&sig=AJfQdSswRQIhAMksY1bPaDeo7kaE4MjZCXN5zu-L-e88u2iW3BiKwxagAiA9S0qI96TRWGQbE9nxBjbXxhrLTcZ61UZ2eRdUar4-ng%3D%3D&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} Jun 01 09:04:03 volumio volumio[1090]: verbose: CURRENT POSITION 0 Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState stateService play Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState currentStatus play Jun 01 09:04:03 volumio volumio[1090]: info: Received an update from plugin. extracting info from payload Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::servicePushState Jun 01 09:04:03 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:03 volumio volumio[1090]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"\"Kashmir Main Tu Kanyakumari\" Chennai Express Full Video Song | Shahrukh Khan, Deepika Padukone","artist":"T-Series","album":"YouTube","uri":"https://rr1---sn-4g5edn6k.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aPveKoj3xN8P5vO5uAg&ip=46.223.28.163&id=o-AErSROHySLr_3dL94cXSWycqyMr8Xbb-7wTn7RHGSAyo&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C29&mn=sn-4g5edn6k%2Csn-4g5e6nsd&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&initcwndbps=2766250&bui=AY1jyLN-_awjcoaQgvIm0_MTdDlZJsqVPVxbuj0zzGUhxSBNpiRG1i_yQABWGmGBaJmG4IvSbw1bSjns&spc=l3OVKZz9xk7b0eEB_BGiYtfDbobNirCJah98C3P2bXL7VHhux-R9C-HDpMBt2LfAWgo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga32283lptzkiUTLTeoiSj4Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761260&fvip=4&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=uEsdeVyqfv4GNQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgVTHdD8TIyacHHXT4T-nnmbBvaultUreOs19GiZ30vbUCIHz5aluvBaWZ__H35GEgR6pqwLQ9QG4Qim1xFaDoWlxt&sig=AJfQdSswRQIhAMksY1bPaDeo7kaE4MjZCXN5zu-L-e88u2iW3BiKwxagAiA9S0qI96TRWGQbE9nxBjbXxhrLTcZ61UZ2eRdUar4-ng%3D%3D&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} Jun 01 09:04:03 volumio volumio[1090]: verbose: CURRENT POSITION 0 Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState stateService play Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState currentStatus play Jun 01 09:04:03 volumio volumio[1090]: info: Received an update from plugin. extracting info from payload Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::servicePushState Jun 01 09:04:03 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:03 volumio volumio[1090]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"\"Kashmir Main Tu Kanyakumari\" Chennai Express Full Video Song | Shahrukh Khan, Deepika Padukone","artist":"T-Series","album":"YouTube","uri":"https://rr1---sn-4g5edn6k.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aPveKoj3xN8P5vO5uAg&ip=46.223.28.163&id=o-AErSROHySLr_3dL94cXSWycqyMr8Xbb-7wTn7RHGSAyo&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C29&mn=sn-4g5edn6k%2Csn-4g5e6nsd&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&initcwndbps=2766250&bui=AY1jyLN-_awjcoaQgvIm0_MTdDlZJsqVPVxbuj0zzGUhxSBNpiRG1i_yQABWGmGBaJmG4IvSbw1bSjns&spc=l3OVKZz9xk7b0eEB_BGiYtfDbobNirCJah98C3P2bXL7VHhux-R9C-HDpMBt2LfAWgo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga32283lptzkiUTLTeoiSj4Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761260&fvip=4&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=uEsdeVyqfv4GNQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgVTHdD8TIyacHHXT4T-nnmbBvaultUreOs19GiZ30vbUCIHz5aluvBaWZ__H35GEgR6pqwLQ9QG4Qim1xFaDoWlxt&sig=AJfQdSswRQIhAMksY1bPaDeo7kaE4MjZCXN5zu-L-e88u2iW3BiKwxagAiA9S0qI96TRWGQbE9nxBjbXxhrLTcZ61UZ2eRdUar4-ng%3D%3D&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} Jun 01 09:04:03 volumio volumio[1090]: verbose: CURRENT POSITION 0 Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState stateService play Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState currentStatus play Jun 01 09:04:03 volumio volumio[1090]: info: Received an update from plugin. extracting info from payload Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: ------------------------------ 324ms Jun 01 09:04:03 volumio volumio[1090]: info: ------------------------------ 326ms Jun 01 09:04:03 volumio volumio[1090]: info: ------------------------------ 327ms Jun 01 09:04:03 volumio volumio[1090]: info: ------------------------------ 301ms Jun 01 09:04:03 volumio volumio[1090]: info: sendMpdCommand playlistinfo took 252 milliseconds Jun 01 09:04:03 volumio volumio[1090]: verbose: ControllerMpd::parseTrackInfo Jun 01 09:04:03 volumio volumio[1090]: info: ControllerMpd::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::servicePushState Jun 01 09:04:03 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 01 09:04:03 volumio volumio[1090]: verbose: STATE SERVICE {"status":"play","position":0,"seek":238,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"\"Kashmir Main Tu Kanyakumari\" Chennai Express Full Video Song | Shahrukh Khan, Deepika Padukone","artist":"T-Series","album":"YouTube","uri":"https://rr1---sn-4g5edn6k.googlevideo.com/videoplayback?expire=1748783038&ei=Xvs7aPveKoj3xN8P5vO5uAg&ip=46.223.28.163&id=o-AErSROHySLr_3dL94cXSWycqyMr8Xbb-7wTn7RHGSAyo&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748761438%2C&mh=J9&mm=31%2C29&mn=sn-4g5edn6k%2Csn-4g5e6nsd&ms=au%2Crdu&mv=m&mvi=1&pl=20&rms=au%2Cau&initcwndbps=2766250&bui=AY1jyLN-_awjcoaQgvIm0_MTdDlZJsqVPVxbuj0zzGUhxSBNpiRG1i_yQABWGmGBaJmG4IvSbw1bSjns&spc=l3OVKZz9xk7b0eEB_BGiYtfDbobNirCJah98C3P2bXL7VHhux-R9C-HDpMBt2LfAWgo&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Ga32283lptzkiUTLTeoiSj4Q&rqh=1&gir=yes&clen=3790526&dur=221.981&lmt=1735286884785246&mt=1748761260&fvip=4&keepalive=yes&fexp=51355912&c=WEB&sefc=1&txp=4532434&n=uEsdeVyqfv4GNQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgVTHdD8TIyacHHXT4T-nnmbBvaultUreOs19GiZ30vbUCIHz5aluvBaWZ__H35GEgR6pqwLQ9QG4Qim1xFaDoWlxt&sig=AJfQdSswRQIhAMksY1bPaDeo7kaE4MjZCXN5zu-L-e88u2iW3BiKwxagAiA9S0qI96TRWGQbE9nxBjbXxhrLTcZ61UZ2eRdUar4-ng%3D%3D&pot=Mnj6rLOSo9Ukp_qQsyPTBjOSl-6kVp8SeDDtiGu-p2cTLQFOpXyK4EoYiRbBXBq8RsIcp7g-0LWsQTkLMnmwF2HAxCsBxUwv89BjiWxNaAyUi2zGK8VK23SrZUSkHyGlREAsFsDFyGY0XjUFTL5GrKkGb6fZV0tNnyE%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} Jun 01 09:04:03 volumio volumio[1090]: verbose: CURRENT POSITION 0 Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState stateService play Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::syncState currentStatus play Jun 01 09:04:03 volumio volumio[1090]: info: Received an update from plugin. extracting info from payload Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:03 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:03 volumio volumio[1090]: info: ------------------------------ 457ms Jun 01 09:04:04 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 01 09:04:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 09:04:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 09:04:05 volumio volumio[1090]: info: Discovery: Getting this device information Jun 01 09:04:05 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 09:04:35 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 09:04:35 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 09:04:35 volumio volumio[1090]: info: Discovery: Getting this device information Jun 01 09:04:35 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:35 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 09:04:42 volumio volumio[1090]: info: VolumeController::SetAlsaVolume52 Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:42 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:42 volumio volumio[1090]: info: VolumeController::SetAlsaVolume53 Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:42 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:42 volumio volumio[1090]: info: VolumeController::SetAlsaVolume54 Jun 01 09:04:42 volumio volumio[1090]: info: VolumeController::SetAlsaVolume55 Jun 01 09:04:42 volumio volumio[1090]: info: VolumeController::SetAlsaVolume56 Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:42 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:42 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:42 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:42 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume54 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume55 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume56 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume57 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume58 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume57 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume58 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume59 Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:43 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:43 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:43 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:43 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:43 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:43 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:43 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:43 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:43 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume60 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume61 Jun 01 09:04:43 volumio volumio[1090]: info: VolumeController::SetAlsaVolume62 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume63 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume64 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume65 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume66 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume67 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume68 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume69 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume70 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume71 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume72 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume73 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume74 Jun 01 09:04:44 volumio volumio[1090]: info: VolumeController::SetAlsaVolume60 Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:44 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:44 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:45 volumio volumio[1090]: info: VolumeController::SetAlsaVolume60 Jun 01 09:04:45 volumio volumio[1090]: info: VolumeController::SetAlsaVolume61 Jun 01 09:04:45 volumio volumio[1090]: info: VolumeController::SetAlsaVolume62 Jun 01 09:04:45 volumio volumio[1090]: info: VolumeController::SetAlsaVolume63 Jun 01 09:04:45 volumio volumio[1090]: info: VolumeController::SetAlsaVolume64 Jun 01 09:04:45 volumio volumio[1090]: info: VolumeController::SetAlsaVolume65 Jun 01 09:04:46 volumio volumio[1090]: info: VolumeController::SetAlsaVolume66 Jun 01 09:04:46 volumio volumio[1090]: info: VolumeController::SetAlsaVolume67 Jun 01 09:04:46 volumio volumio[1090]: info: VolumeController::SetAlsaVolume68 Jun 01 09:04:46 volumio volumio[1090]: info: VolumeController::SetAlsaVolume69 Jun 01 09:04:46 volumio volumio[1090]: info: VolumeController::SetAlsaVolume70 Jun 01 09:04:46 volumio volumio[1090]: info: VolumeController::SetAlsaVolume71 Jun 01 09:04:46 volumio volumio[1090]: info: VolumeController::SetAlsaVolume72 Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:04:46 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 01 09:04:46 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 01 09:04:51 volumio volumio[1090]: info: CoreCommandRouter::volumioGetQueue Jun 01 09:04:51 volumio volumio[1090]: info: CoreStateMachine::getQueue Jun 01 09:04:51 volumio volumio[1090]: info: CorePlayQueue::getQueue Jun 01 09:04:57 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 01 09:04:57 volumio volumio[1090]: info: Preload queue cleared Jun 01 09:04:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 01 09:04:59 volumio volumio[1090]: info: TuneIn handleBrowseUri: tunein/local Jun 01 09:05:00 volumio volumio[1090]: info: Preload queue cleared Jun 01 09:05:00 volumio volumio[1090]: info: Preload queue cleared Jun 01 09:05:03 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 01 09:05:03 volumio volumio[1090]: info: Preload queue cleared Jun 01 09:05:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 01 09:05:05 volumio volumio[1090]: info: Preload queue cleared Jun 01 09:05:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 09:05:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 09:05:05 volumio volumio[1090]: info: Discovery: Getting this device information Jun 01 09:05:05 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 01 09:05:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 09:05:08 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 01 09:05:08 volumio volumio[1090]: info: Getting webradio selection Jun 01 09:05:08 volumio volumio[1090]: info: Preload queue cleared Jun 01 09:05:13 volumio volumio[1090]: Searching plugin music_service/webradio Jun 01 09:05:13 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 01 09:05:13 volumio volumio[1090]: Use XMLElement.setAttribute instead Jun 01 09:05:14 volumio volumio[1090]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 09:05:14 volumio volumio[1090]: TypeError: children[i].attr(...).value is not a function Jun 01 09:05:14 volumio volumio[1090]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 01 09:05:14 volumio volumio[1090]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 01 09:05:14 volumio volumio[1090]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 09:05:17 volumio sudo[2060]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-01 09:04' Jun 01 09:05:17 volumio sudo[2060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 09:05:18 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 01 09:05:18 volumio dbus-daemon[566]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.26' (uid=0 pid=2063 comm="timedatectl show --property=NTPSynchronized --valu") Jun 01 09:05:18 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... 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"