May 29 14:37:11 volumio-jonas volumio[1111]: Searching plugin music_service/youtube2 May 29 14:37:11 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 29 14:37:12 volumio-jonas volumio[1111]: info: All search sources collected, pushing search results May 29 14:37:14 volumio-jonas volumio[1111]: Searching plugin music_service/youtube2 May 29 14:37:14 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 29 14:37:15 volumio-jonas volumio[1111]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 29 14:37:15 volumio-jonas volumio[1111]: command_run: { startIndex: 0, length: 61, onTap: { innertubeCommand: [Object] } }, May 29 14:37:15 volumio-jonas volumio[1111]: input_data: { May 29 14:37:15 volumio-jonas volumio[1111]: content: 'Helene Fischer - Achterbahn (Live - Die Stadion-Tour) · 7:11', May 29 14:37:15 volumio-jonas volumio[1111]: commandRuns: [ [Object] ] May 29 14:37:15 volumio-jonas volumio[1111]: }, May 29 14:37:15 volumio-jonas volumio[1111]: parsed_runs: [ May 29 14:37:15 volumio-jonas volumio[1111]: { May 29 14:37:15 volumio-jonas volumio[1111]: text: 'Helene Fischer - Achterbahn (Live - Die Stadion-Tour) · 7:11', May 29 14:37:15 volumio-jonas volumio[1111]: startIndex: 0 May 29 14:37:15 volumio-jonas volumio[1111]: } May 29 14:37:15 volumio-jonas volumio[1111]: ] May 29 14:37:15 volumio-jonas volumio[1111]: } May 29 14:37:15 volumio-jonas volumio[1111]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 29 14:37:15 volumio-jonas volumio[1111]: command_run: { startIndex: 0, length: 48, onTap: { innertubeCommand: [Object] } }, May 29 14:37:15 volumio-jonas volumio[1111]: input_data: { May 29 14:37:15 volumio-jonas volumio[1111]: content: 'Helene Fischer - Atemlos durch die Nacht · 3:39', May 29 14:37:15 volumio-jonas volumio[1111]: commandRuns: [ [Object] ] May 29 14:37:15 volumio-jonas volumio[1111]: }, May 29 14:37:15 volumio-jonas volumio[1111]: parsed_runs: [ May 29 14:37:15 volumio-jonas volumio[1111]: { May 29 14:37:15 volumio-jonas volumio[1111]: text: 'Helene Fischer - Atemlos durch die Nacht · 3:39', May 29 14:37:15 volumio-jonas volumio[1111]: startIndex: 0 May 29 14:37:15 volumio-jonas volumio[1111]: } May 29 14:37:15 volumio-jonas volumio[1111]: ] May 29 14:37:15 volumio-jonas volumio[1111]: } May 29 14:37:15 volumio-jonas volumio[1111]: info: All search sources collected, pushing search results May 29 14:37:16 volumio-jonas volumio[1111]: Searching plugin music_service/youtube2 May 29 14:37:16 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 29 14:37:17 volumio-jonas volumio[1111]: info: All search sources collected, pushing search results May 29 14:37:25 volumio-jonas volumio[1111]: info: Preload queue cleared May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioReplaceandPlayItems May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::ClearQueue May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::stop May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::stPlaybackTimer May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::updateTrackBlock May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrackBlock May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::serviceStop May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::serviceStop May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::setConsumeUpdateService mpd May 29 14:37:25 volumio-jonas volumio[1111]: info: ControllerMpd::stop May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand stop May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::clearPlayQueue May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::saveQueue May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushQueue May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::addQueueItems May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::addQueueItems May 29 14:37:25 volumio-jonas volumio[1111]: info: Preload queue cleared May 29 14:37:25 volumio-jonas volumio[1111]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Helene%20Fischer%20-%20Achterbahn%22%2C%22artist%22%3A%22Helene%20Fischer%20(Official)%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FJfwjsjBcDoU%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBqhHElaTsbYNpq7pyXvzq5g29Kbg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22JfwjsjBcDoU%22%2C%22params%22%3A%22qgMZaGVsZW5lIEZpc2NoZXIgQWNodGVyYmFobroDCgiR1cm8svDUrFO6Aw8SDVJESmZ3anNqQmNEb1W6AwsIzsP_vPmNzv7IAboDCwj1-Kj7nJGuovEBugMLCN7KgsGlt9nKwAG6AwoI6pLJvIjqr6NYugMKCOmWx5HUicS0O7oDCwi9msyNgL2gxZUBugMLCPnY-qT-ycDQhQG6AwoIsM7bqr7Yvp4tugMLCP28u6bGn5Hq1wG6AwsItPnPx52RrbPUAboDCwjmi_HdzKSikvMBugMLCOnYlq_RhMGl5AG6AwoIzPOGu9TggeggugMKCNTik6Wa1M2-M7oDCQjX4sD818Krf7oDCwjH9O3lne2w_coBugMKCLm7ma7rqOyjS_IDBQ1RBuA8ggQCEAE%253D%22%7D%7D%7D May 29 14:37:25 volumio-jonas volumio[1111]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Helene%20Fischer%20-%20Achterbahn%22%2C%22artist%22%3A%22Helene%20Fischer%20(Official)%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FJfwjsjBcDoU%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBqhHElaTsbYNpq7pyXvzq5g29Kbg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22JfwjsjBcDoU%22%2C%22params%22%3A%22qgMZaGVsZW5lIEZpc2NoZXIgQWNodGVyYmFobroDCgiR1cm8svDUrFO6Aw8SDVJESmZ3anNqQmNEb1W6AwsIzsP_vPmNzv7IAboDCwj1-Kj7nJGuovEBugMLCN7KgsGlt9nKwAG6AwoI6pLJvIjqr6NYugMKCOmWx5HUicS0O7oDCwi9msyNgL2gxZUBugMLCPnY-qT-ycDQhQG6AwoIsM7bqr7Yvp4tugMLCP28u6bGn5Hq1wG6AwsItPnPx52RrbPUAboDCwjmi_HdzKSikvMBugMLCOnYlq_RhMGl5AG6AwoIzPOGu9TggeggugMKCNTik6Wa1M2-M7oDCQjX4sD818Krf7oDCwjH9O3lne2w_coBugMKCLm7ma7rqOyjS_IDBQ1RBuA8ggQCEAE%253D%22%7D%7D%7D in service youtube2 May 29 14:37:25 volumio-jonas volumio[1111]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Helene%20Fischer%20-%20Achterbahn%22%2C%22artist%22%3A%22Helene%20Fischer%20(Official)%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FJfwjsjBcDoU%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBqhHElaTsbYNpq7pyXvzq5g29Kbg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22JfwjsjBcDoU%22%2C%22params%22%3A%22qgMZaGVsZW5lIEZpc2NoZXIgQWNodGVyYmFobroDCgiR1cm8svDUrFO6Aw8SDVJESmZ3anNqQmNEb1W6AwsIzsP_vPmNzv7IAboDCwj1-Kj7nJGuovEBugMLCN7KgsGlt9nKwAG6AwoI6pLJvIjqr6NYugMKCOmWx5HUicS0O7oDCwi9msyNgL2gxZUBugMLCPnY-qT-ycDQhQG6AwoIsM7bqr7Yvp4tugMLCP28u6bGn5Hq1wG6AwsItPnPx52RrbPUAboDCwjmi_HdzKSikvMBugMLCOnYlq_RhMGl5AG6AwoIzPOGu9TggeggugMKCNTik6Wa1M2-M7oDCQjX4sD818Krf7oDCwjH9O3lne2w_coBugMKCLm7ma7rqOyjS_IDBQ1RBuA8ggQCEAE%253D%22%7D%7D%7D May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushQueue May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::saveQueue May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::updateTrackBlock May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrackBlock May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPlay May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::play index 0 May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::stop May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::play index undefined May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::startPlaybackTimer May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:25 volumio-jonas volumio[1111]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22JfwjsjBcDoU%22%2C%22params%22%3A%22qgMZaGVsZW5lIEZpc2NoZXIgQWNodGVyYmFobroDCgiR1cm8svDUrFO6Aw8SDVJESmZ3anNqQmNEb1W6AwsIzsP_vPmNzv7IAboDCwj1-Kj7nJGuovEBugMLCN7KgsGlt9nKwAG6AwoI6pLJvIjqr6NYugMKCOmWx5HUicS0O7oDCwi9msyNgL2gxZUBugMLCPnY-qT-ycDQhQG6AwoIsM7bqr7Yvp4tugMLCP28u6bGn5Hq1wG6AwsItPnPx52RrbPUAboDCwjmi_HdzKSikvMBugMLCOnYlq_RhMGl5AG6AwoIzPOGu9TggeggugMKCNTik6Wa1M2-M7oDCQjX4sD818Krf7oDCwjH9O3lne2w_coBugMKCLm7ma7rqOyjS_IDBQ1RBuA8ggQCEAE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Helene%20Fischer%20-%20Achterbahn%22%2C%22artist%22%3A%22Helene%20Fischer%20(Official)%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FJfwjsjBcDoU%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBqhHElaTsbYNpq7pyXvzq5g29Kbg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22JfwjsjBcDoU%22%2C%22params%22%3A%22qgMZaGVsZW5lIEZpc2NoZXIgQWNodGVyYmFobroDCgiR1cm8svDUrFO6Aw8SDVJESmZ3anNqQmNEb1W6AwsIzsP_vPmNzv7IAboDCwj1-Kj7nJGuovEBugMLCN7KgsGlt9nKwAG6AwoI6pLJvIjqr6NYugMKCOmWx5HUicS0O7oDCwi9msyNgL2gxZUBugMLCPnY-qT-ycDQhQG6AwoIsM7bqr7Yvp4tugMLCP28u6bGn5Hq1wG6AwsItPnPx52RrbPUAboDCwjmi_HdzKSikvMBugMLCOnYlq_RhMGl5AG6AwoIzPOGu9TggeggugMKCNTik6Wa1M2-M7oDCQjX4sD818Krf7oDCwjH9O3lne2w_coBugMKCLm7ma7rqOyjS_IDBQ1RBuA8ggQCEAE%253D%22%7D%7D%7D May 29 14:37:25 volumio-jonas volumio[1111]: info: May 29 14:37:25 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:25 volumio-jonas volumio[1111]: info: sendMpdCommand stop took 288 milliseconds May 29 14:37:25 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:25 volumio-jonas volumio[1111]: info: May 29 14:37:25 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:25 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:25 volumio-jonas volumio[1111]: info: May 29 14:37:25 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:25 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:25 volumio-jonas volumio[1111]: info: sendMpdCommand status took 47 milliseconds May 29 14:37:25 volumio-jonas volumio[1111]: info: sendMpdCommand status took 43 milliseconds May 29 14:37:25 volumio-jonas volumio[1111]: info: sendMpdCommand status took 37 milliseconds May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:25 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 8 milliseconds May 29 14:37:25 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 17 milliseconds May 29 14:37:25 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 12 milliseconds May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:25 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:25 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:25 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 29 14:37:25 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:26 volumio-jonas volumio[1111]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd May 29 14:37:26 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:26 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:26 volumio-jonas volumio[1111]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd May 29 14:37:26 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:26 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:26 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:26 volumio-jonas volumio[1111]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd May 29 14:37:26 volumio-jonas volumio[1111]: info: ------------------------------ 279ms May 29 14:37:26 volumio-jonas volumio[1111]: info: ------------------------------ 255ms May 29 14:37:26 volumio-jonas volumio[1111]: info: ------------------------------ 243ms May 29 14:37:26 volumio-jonas volumio[1111]: info: touch_display: Setting screensaver timeout to 120 seconds. May 29 14:37:27 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:27 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand stop May 29 14:37:27 volumio-jonas volumio[1111]: info: sendMpdCommand stop took 1 milliseconds May 29 14:37:27 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand clear May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: info: sendMpdCommand clear took 2 milliseconds May 29 14:37:27 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand addid "https://rr3---sn-h0jeln7e.googlevideo.com/videoplayback?expire=1748543846&ei=BlU4aKDuFYTmxN8P5rn8kAw&ip=79.219.239.191&id=o-AMMUZDU-YcwbOXPyAoYnveqiHPPiSvpMTj6RViijDVEq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748522246%2C&mh=o2&mm=31%2C29&mn=sn-h0jeln7e%2Csn-h0jeenl6&ms=au%2Crdu&mv=m&mvi=3&pl=26&rms=au%2Cau&initcwndbps=2491250&bui=AY1jyLNpQSbn6djE6V_idJ0Urr14t0Vd7HglQOl7i36ObR2MwXSx77Va77eUO6bV4eI6xQxUFIrNcxQY&spc=l3OVKRAUf7zXme0_hAjl0zkZOXKCoC8fyj2QjKNWX7HOosuVWwgwB5Caayf9_SXrYDg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=O9C2mYeJghc6XLayXPXo3PQQ&rqh=1&gir=yes&clen=3637644&dur=221.941&lmt=1714588222895482&mt=1748521984&fvip=4&keepalive=yes&fexp=51355912%2C51466643&c=WEB&sefc=1&txp=4502434&n=bW2aAvtpJqXSbA&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=APaTxxMwRAIgJA1hId6uKZ8ssr4QLlJZc-ymBY2U-_n0gVoujagp7G4CIHy4jHzJIoEMZa_detG8frGg8MHe2eNFhdA8lvlYeX1j&sig=AJfQdSswRgIhAP8U6Pml7OYDY6Q5EuxcNuCvUOsm4CyP5sOlZ65p77bnAiEAmCXY0cqQ9UpDJHYZZOLvnY_8P76ze0Jkxfxw4-UhFbU%3D&pot=MngMHAWWiDkDWwwgBNKXk6igaADXuNWjtXuLEd_MHYiDDK_Nki9Ha8QaaMUy_uHqm2L-m3Ve8KHF1w6fG1Z7KwYmHT6wxvw6qTNM479Q8jUHxz-ofYcNitbIAwX9oXYyqI3Zl-zQVfFCuPZ4T0EZEtSmG5Gghq_i3x0%3D&cver=2.20250222.10.00&t.YouTube" May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: error: updateQueue error: null May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 16ms May 29 14:37:27 volumio-jonas volumio[1111]: info: sendMpdCommand addid "https://rr3---sn-h0jeln7e.googlevideo.com/videoplayback?expire=1748543846&ei=BlU4aKDuFYTmxN8P5rn8kAw&ip=79.219.239.191&id=o-AMMUZDU-YcwbOXPyAoYnveqiHPPiSvpMTj6RViijDVEq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748522246%2C&mh=o2&mm=31%2C29&mn=sn-h0jeln7e%2Csn-h0jeenl6&ms=au%2Crdu&mv=m&mvi=3&pl=26&rms=au%2Cau&initcwndbps=2491250&bui=AY1jyLNpQSbn6djE6V_idJ0Urr14t0Vd7HglQOl7i36ObR2MwXSx77Va77eUO6bV4eI6xQxUFIrNcxQY&spc=l3OVKRAUf7zXme0_hAjl0zkZOXKCoC8fyj2QjKNWX7HOosuVWwgwB5Caayf9_SXrYDg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=O9C2mYeJghc6XLayXPXo3PQQ&rqh=1&gir=yes&clen=3637644&dur=221.941&lmt=1714588222895482&mt=1748521984&fvip=4&keepalive=yes&fexp=51355912%2C51466643&c=WEB&sefc=1&txp=4502434&n=bW2aAvtpJqXSbA&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=APaTxxMwRAIgJA1hId6uKZ8ssr4QLlJZc-ymBY2U-_n0gVoujagp7G4CIHy4jHzJIoEMZa_detG8frGg8MHe2eNFhdA8lvlYeX1j&sig=AJfQdSswRgIhAP8U6Pml7OYDY6Q5EuxcNuCvUOsm4CyP5sOlZ65p77bnAiEAmCXY0cqQ9UpDJHYZZOLvnY_8P76ze0Jkxfxw4-UhFbU%3D&pot=MngMHAWWiDkDWwwgBNKXk6igaADXuNWjtXuLEd_MHYiDDK_Nki9Ha8QaaMUy_uHqm2L-m3Ve8KHF1w6fG1Z7KwYmHT6wxvw6qTNM479Q8jUHxz-ofYcNitbIAwX9oXYyqI3Zl-zQVfFCuPZ4T0EZEtSmG5Gghq_i3x0%3D&cver=2.20250222.10.00&t.YouTube" took 15 milliseconds May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 17ms May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 13ms May 29 14:37:27 volumio-jonas volumio[1111]: verbose: MPD COMMAND [object Object] May 29 14:37:27 volumio-jonas volumio[1111]: verbose: MPD COMMAND [object Object] May 29 14:37:27 volumio-jonas volumio[1111]: verbose: MPD COMMAND [object Object] May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 20ms May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 9ms May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 6ms May 29 14:37:27 volumio-jonas volumio[1111]: info: CoreStateMachine::setConsumeUpdateService mpd May 29 14:37:27 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand play May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: info: May 29 14:37:27 volumio-jonas volumio[1111]: ---------------------------- MPD announces system playlist update May 29 14:37:27 volumio-jonas volumio[1111]: info: Ignoring MPD Status Update May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 15ms May 29 14:37:27 volumio-jonas volumio[1111]: info: sendMpdCommand play took 12 milliseconds May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 12ms May 29 14:37:27 volumio-jonas volumio[1111]: info: ------------------------------ 8ms May 29 14:37:28 volumio-jonas volumio[1111]: info: May 29 14:37:28 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:28 volumio-jonas volumio[1111]: info: May 29 14:37:28 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:28 volumio-jonas volumio[1111]: info: May 29 14:37:28 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:28 volumio-jonas volumio[1111]: info: May 29 14:37:28 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand status took 6 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:28 volumio-jonas volumio[1111]: info: May 29 14:37:28 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:28 volumio-jonas volumio[1111]: info: May 29 14:37:28 volumio-jonas volumio[1111]: ---------------------------- MPD announces state update: player May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::getState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand status May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand status took 31 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand status took 28 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand status took 27 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 22 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand status took 15 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:28 volumio-jonas volumio[1111]: 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":"Helene Fischer - Achterbahn","artist":"Helene Fischer (Official)","album":"YouTube","uri":"https://rr3---sn-h0jeln7e.googlevideo.com/videoplayback?expire=1748543846&ei=BlU4aKDuFYTmxN8P5rn8kAw&ip=79.219.239.191&id=o-AMMUZDU-YcwbOXPyAoYnveqiHPPiSvpMTj6RViijDVEq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748522246%2C&mh=o2&mm=31%2C29&mn=sn-h0jeln7e%2Csn-h0jeenl6&ms=au%2Crdu&mv=m&mvi=3&pl=26&rms=au%2Cau&initcwndbps=2491250&bui=AY1jyLNpQSbn6djE6V_idJ0Urr14t0Vd7HglQOl7i36ObR2MwXSx77Va77eUO6bV4eI6xQxUFIrNcxQY&spc=l3OVKRAUf7zXme0_hAjl0zkZOXKCoC8fyj2QjKNWX7HOosuVWwgwB5Caayf9_SXrYDg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=O9C2mYeJghc6XLayXPXo3PQQ&rqh=1&gir=yes&clen=3637644&dur=221.941&lmt=1714588222895482&mt=1748521984&fvip=4&keepalive=yes&fexp=51355912%2C51466643&c=WEB&sefc=1&txp=4502434&n=bW2aAvtpJqXSbA&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=APaTxxMwRAIgJA1hId6uKZ8ssr4QLlJZc-ymBY2U-_n0gVoujagp7G4CIHy4jHzJIoEMZa_detG8frGg8MHe2eNFhdA8lvlYeX1j&sig=AJfQdSswRgIhAP8U6Pml7OYDY6Q5EuxcNuCvUOsm4CyP5sOlZ65p77bnAiEAmCXY0cqQ9UpDJHYZZOLvnY_8P76ze0Jkxfxw4-UhFbU%3D&pot=MngMHAWWiDkDWwwgBNKXk6igaADXuNWjtXuLEd_MHYiDDK_Nki9Ha8QaaMUy_uHqm2L-m3Ve8KHF1w6fG1Z7KwYmHT6wxvw6qTNM479Q8jUHxz-ofYcNitbIAwX9oXYyqI3Zl-zQVfFCuPZ4T0EZEtSmG5Gghq_i3x0%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 29 14:37:28 volumio-jonas volumio[1111]: verbose: CURRENT POSITION 0 May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState stateService play May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState currentStatus stop May 29 14:37:28 volumio-jonas volumio[1111]: info: ------------------------------ 62ms May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand status took 32 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 20 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 25 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 25 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 19 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseState May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:28 volumio-jonas volumio[1111]: 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":"Helene Fischer - Achterbahn","artist":"Helene Fischer (Official)","album":"YouTube","uri":"https://rr3---sn-h0jeln7e.googlevideo.com/videoplayback?expire=1748543846&ei=BlU4aKDuFYTmxN8P5rn8kAw&ip=79.219.239.191&id=o-AMMUZDU-YcwbOXPyAoYnveqiHPPiSvpMTj6RViijDVEq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748522246%2C&mh=o2&mm=31%2C29&mn=sn-h0jeln7e%2Csn-h0jeenl6&ms=au%2Crdu&mv=m&mvi=3&pl=26&rms=au%2Cau&initcwndbps=2491250&bui=AY1jyLNpQSbn6djE6V_idJ0Urr14t0Vd7HglQOl7i36ObR2MwXSx77Va77eUO6bV4eI6xQxUFIrNcxQY&spc=l3OVKRAUf7zXme0_hAjl0zkZOXKCoC8fyj2QjKNWX7HOosuVWwgwB5Caayf9_SXrYDg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=O9C2mYeJghc6XLayXPXo3PQQ&rqh=1&gir=yes&clen=3637644&dur=221.941&lmt=1714588222895482&mt=1748521984&fvip=4&keepalive=yes&fexp=51355912%2C51466643&c=WEB&sefc=1&txp=4502434&n=bW2aAvtpJqXSbA&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=APaTxxMwRAIgJA1hId6uKZ8ssr4QLlJZc-ymBY2U-_n0gVoujagp7G4CIHy4jHzJIoEMZa_detG8frGg8MHe2eNFhdA8lvlYeX1j&sig=AJfQdSswRgIhAP8U6Pml7OYDY6Q5EuxcNuCvUOsm4CyP5sOlZ65p77bnAiEAmCXY0cqQ9UpDJHYZZOLvnY_8P76ze0Jkxfxw4-UhFbU%3D&pot=MngMHAWWiDkDWwwgBNKXk6igaADXuNWjtXuLEd_MHYiDDK_Nki9Ha8QaaMUy_uHqm2L-m3Ve8KHF1w6fG1Z7KwYmHT6wxvw6qTNM479Q8jUHxz-ofYcNitbIAwX9oXYyqI3Zl-zQVfFCuPZ4T0EZEtSmG5Gghq_i3x0%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 29 14:37:28 volumio-jonas volumio[1111]: verbose: CURRENT POSITION 0 May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState stateService play May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState currentStatus play May 29 14:37:28 volumio-jonas volumio[1111]: info: Received an update from plugin. extracting info from payload May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:28 volumio-jonas volumio[1111]: verbose: STATE SERVICE {"status":"play","position":0,"seek":333,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Helene Fischer - Achterbahn","artist":"Helene Fischer (Official)","album":"YouTube","uri":"https://rr3---sn-h0jeln7e.googlevideo.com/videoplayback?expire=1748543846&ei=BlU4aKDuFYTmxN8P5rn8kAw&ip=79.219.239.191&id=o-AMMUZDU-YcwbOXPyAoYnveqiHPPiSvpMTj6RViijDVEq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748522246%2C&mh=o2&mm=31%2C29&mn=sn-h0jeln7e%2Csn-h0jeenl6&ms=au%2Crdu&mv=m&mvi=3&pl=26&rms=au%2Cau&initcwndbps=2491250&bui=AY1jyLNpQSbn6djE6V_idJ0Urr14t0Vd7HglQOl7i36ObR2MwXSx77Va77eUO6bV4eI6xQxUFIrNcxQY&spc=l3OVKRAUf7zXme0_hAjl0zkZOXKCoC8fyj2QjKNWX7HOosuVWwgwB5Caayf9_SXrYDg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=O9C2mYeJghc6XLayXPXo3PQQ&rqh=1&gir=yes&clen=3637644&dur=221.941&lmt=1714588222895482&mt=1748521984&fvip=4&keepalive=yes&fexp=51355912%2C51466643&c=WEB&sefc=1&txp=4502434&n=bW2aAvtpJqXSbA&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=APaTxxMwRAIgJA1hId6uKZ8ssr4QLlJZc-ymBY2U-_n0gVoujagp7G4CIHy4jHzJIoEMZa_detG8frGg8MHe2eNFhdA8lvlYeX1j&sig=AJfQdSswRgIhAP8U6Pml7OYDY6Q5EuxcNuCvUOsm4CyP5sOlZ65p77bnAiEAmCXY0cqQ9UpDJHYZZOLvnY_8P76ze0Jkxfxw4-UhFbU%3D&pot=MngMHAWWiDkDWwwgBNKXk6igaADXuNWjtXuLEd_MHYiDDK_Nki9Ha8QaaMUy_uHqm2L-m3Ve8KHF1w6fG1Z7KwYmHT6wxvw6qTNM479Q8jUHxz-ofYcNitbIAwX9oXYyqI3Zl-zQVfFCuPZ4T0EZEtSmG5Gghq_i3x0%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 29 14:37:28 volumio-jonas volumio[1111]: verbose: CURRENT POSITION 0 May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState stateService play May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState currentStatus play May 29 14:37:28 volumio-jonas volumio[1111]: info: Received an update from plugin. extracting info from payload May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:28 volumio-jonas volumio[1111]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Helene Fischer - Achterbahn","artist":"Helene Fischer (Official)","album":"YouTube","uri":"https://rr3---sn-h0jeln7e.googlevideo.com/videoplayback?expire=1748543846&ei=BlU4aKDuFYTmxN8P5rn8kAw&ip=79.219.239.191&id=o-AMMUZDU-YcwbOXPyAoYnveqiHPPiSvpMTj6RViijDVEq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748522246%2C&mh=o2&mm=31%2C29&mn=sn-h0jeln7e%2Csn-h0jeenl6&ms=au%2Crdu&mv=m&mvi=3&pl=26&rms=au%2Cau&initcwndbps=2491250&bui=AY1jyLNpQSbn6djE6V_idJ0Urr14t0Vd7HglQOl7i36ObR2MwXSx77Va77eUO6bV4eI6xQxUFIrNcxQY&spc=l3OVKRAUf7zXme0_hAjl0zkZOXKCoC8fyj2QjKNWX7HOosuVWwgwB5Caayf9_SXrYDg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=O9C2mYeJghc6XLayXPXo3PQQ&rqh=1&gir=yes&clen=3637644&dur=221.941&lmt=1714588222895482&mt=1748521984&fvip=4&keepalive=yes&fexp=51355912%2C51466643&c=WEB&sefc=1&txp=4502434&n=bW2aAvtpJqXSbA&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=APaTxxMwRAIgJA1hId6uKZ8ssr4QLlJZc-ymBY2U-_n0gVoujagp7G4CIHy4jHzJIoEMZa_detG8frGg8MHe2eNFhdA8lvlYeX1j&sig=AJfQdSswRgIhAP8U6Pml7OYDY6Q5EuxcNuCvUOsm4CyP5sOlZ65p77bnAiEAmCXY0cqQ9UpDJHYZZOLvnY_8P76ze0Jkxfxw4-UhFbU%3D&pot=MngMHAWWiDkDWwwgBNKXk6igaADXuNWjtXuLEd_MHYiDDK_Nki9Ha8QaaMUy_uHqm2L-m3Ve8KHF1w6fG1Z7KwYmHT6wxvw6qTNM479Q8jUHxz-ofYcNitbIAwX9oXYyqI3Zl-zQVfFCuPZ4T0EZEtSmG5Gghq_i3x0%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 29 14:37:28 volumio-jonas volumio[1111]: verbose: CURRENT POSITION 0 May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState stateService play May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState currentStatus play May 29 14:37:28 volumio-jonas volumio[1111]: info: Received an update from plugin. extracting info from payload May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:28 volumio-jonas volumio[1111]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Helene Fischer - Achterbahn","artist":"Helene Fischer (Official)","album":"YouTube","uri":"https://rr3---sn-h0jeln7e.googlevideo.com/videoplayback?expire=1748543846&ei=BlU4aKDuFYTmxN8P5rn8kAw&ip=79.219.239.191&id=o-AMMUZDU-YcwbOXPyAoYnveqiHPPiSvpMTj6RViijDVEq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748522246%2C&mh=o2&mm=31%2C29&mn=sn-h0jeln7e%2Csn-h0jeenl6&ms=au%2Crdu&mv=m&mvi=3&pl=26&rms=au%2Cau&initcwndbps=2491250&bui=AY1jyLNpQSbn6djE6V_idJ0Urr14t0Vd7HglQOl7i36ObR2MwXSx77Va77eUO6bV4eI6xQxUFIrNcxQY&spc=l3OVKRAUf7zXme0_hAjl0zkZOXKCoC8fyj2QjKNWX7HOosuVWwgwB5Caayf9_SXrYDg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=O9C2mYeJghc6XLayXPXo3PQQ&rqh=1&gir=yes&clen=3637644&dur=221.941&lmt=1714588222895482&mt=1748521984&fvip=4&keepalive=yes&fexp=51355912%2C51466643&c=WEB&sefc=1&txp=4502434&n=bW2aAvtpJqXSbA&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=APaTxxMwRAIgJA1hId6uKZ8ssr4QLlJZc-ymBY2U-_n0gVoujagp7G4CIHy4jHzJIoEMZa_detG8frGg8MHe2eNFhdA8lvlYeX1j&sig=AJfQdSswRgIhAP8U6Pml7OYDY6Q5EuxcNuCvUOsm4CyP5sOlZ65p77bnAiEAmCXY0cqQ9UpDJHYZZOLvnY_8P76ze0Jkxfxw4-UhFbU%3D&pot=MngMHAWWiDkDWwwgBNKXk6igaADXuNWjtXuLEd_MHYiDDK_Nki9Ha8QaaMUy_uHqm2L-m3Ve8KHF1w6fG1Z7KwYmHT6wxvw6qTNM479Q8jUHxz-ofYcNitbIAwX9oXYyqI3Zl-zQVfFCuPZ4T0EZEtSmG5Gghq_i3x0%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 29 14:37:28 volumio-jonas volumio[1111]: verbose: CURRENT POSITION 0 May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState stateService play May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState currentStatus play May 29 14:37:28 volumio-jonas volumio[1111]: info: Received an update from plugin. extracting info from payload May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: ------------------------------ 372ms May 29 14:37:28 volumio-jonas volumio[1111]: info: ------------------------------ 386ms May 29 14:37:28 volumio-jonas volumio[1111]: info: ------------------------------ 384ms May 29 14:37:28 volumio-jonas volumio[1111]: info: ------------------------------ 375ms May 29 14:37:28 volumio-jonas volumio[1111]: info: sendMpdCommand playlistinfo took 326 milliseconds May 29 14:37:28 volumio-jonas volumio[1111]: verbose: ControllerMpd::parseTrackInfo May 29 14:37:28 volumio-jonas volumio[1111]: info: ControllerMpd::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::servicePushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CorePlayQueue::getTrack 0 May 29 14:37:28 volumio-jonas volumio[1111]: verbose: STATE SERVICE {"status":"play","position":0,"seek":996,"duration":222,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Helene Fischer - Achterbahn","artist":"Helene Fischer (Official)","album":"YouTube","uri":"https://rr3---sn-h0jeln7e.googlevideo.com/videoplayback?expire=1748543846&ei=BlU4aKDuFYTmxN8P5rn8kAw&ip=79.219.239.191&id=o-AMMUZDU-YcwbOXPyAoYnveqiHPPiSvpMTj6RViijDVEq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1748522246%2C&mh=o2&mm=31%2C29&mn=sn-h0jeln7e%2Csn-h0jeenl6&ms=au%2Crdu&mv=m&mvi=3&pl=26&rms=au%2Cau&initcwndbps=2491250&bui=AY1jyLNpQSbn6djE6V_idJ0Urr14t0Vd7HglQOl7i36ObR2MwXSx77Va77eUO6bV4eI6xQxUFIrNcxQY&spc=l3OVKRAUf7zXme0_hAjl0zkZOXKCoC8fyj2QjKNWX7HOosuVWwgwB5Caayf9_SXrYDg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=O9C2mYeJghc6XLayXPXo3PQQ&rqh=1&gir=yes&clen=3637644&dur=221.941&lmt=1714588222895482&mt=1748521984&fvip=4&keepalive=yes&fexp=51355912%2C51466643&c=WEB&sefc=1&txp=4502434&n=bW2aAvtpJqXSbA&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=APaTxxMwRAIgJA1hId6uKZ8ssr4QLlJZc-ymBY2U-_n0gVoujagp7G4CIHy4jHzJIoEMZa_detG8frGg8MHe2eNFhdA8lvlYeX1j&sig=AJfQdSswRgIhAP8U6Pml7OYDY6Q5EuxcNuCvUOsm4CyP5sOlZ65p77bnAiEAmCXY0cqQ9UpDJHYZZOLvnY_8P76ze0Jkxfxw4-UhFbU%3D&pot=MngMHAWWiDkDWwwgBNKXk6igaADXuNWjtXuLEd_MHYiDDK_Nki9Ha8QaaMUy_uHqm2L-m3Ve8KHF1w6fG1Z7KwYmHT6wxvw6qTNM479Q8jUHxz-ofYcNitbIAwX9oXYyqI3Zl-zQVfFCuPZ4T0EZEtSmG5Gghq_i3x0%3D&cver=2.20250222.10.00&t.YouTube","trackType":"YouTube"} May 29 14:37:28 volumio-jonas volumio[1111]: verbose: CURRENT POSITION 0 May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState stateService play May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::syncState currentStatus play May 29 14:37:28 volumio-jonas volumio[1111]: info: Received an update from plugin. extracting info from payload May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreStateMachine::pushState May 29 14:37:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::volumioPushState May 29 14:37:28 volumio-jonas volumio[1111]: info: ------------------------------ 509ms May 29 14:38:12 volumio-jonas systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 29 14:38:12 volumio-jonas dbus-daemon[709]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.32' (uid=0 pid=2764 comm="timedatectl show --property=NTPSynchronized --valu") May 29 14:38:12 volumio-jonas systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 29 14:38:12 volumio-jonas dbus-daemon[709]: [system] Successfully activated service 'org.freedesktop.timedate1' May 29 14:38:12 volumio-jonas systemd[1]: Started systemd-timedated.service - Time & Date Service. May 29 14:38:12 volumio-jonas setdatetime-helper.sh[2763]: Time is not synchronized. Attempting to sync... May 29 14:38:13 volumio-jonas sudo[2772]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Thu, 29 May 2025 12:38:13 GMT#015' May 29 14:38:13 volumio-jonas sudo[2772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 29 14:38:13 volumio-jonas setdatetime-helper.sh[2773]: Thu May 29 14:38:13 CEST 2025 May 29 14:38:13 volumio-jonas sudo[2772]: pam_unix(sudo:session): session closed for user root May 29 14:38:13 volumio-jonas setdatetime-helper.sh[2763]: Time synchronized successfully. May 29 14:38:13 volumio-jonas systemd-journald[339]: Time jumped backwards, rotating. May 29 14:38:13 volumio-jonas systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 29 14:38:13 volumio-jonas systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 29 14:38:28 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 29 14:38:28 volumio-jonas volumio[1111]: info: Preload queue cleared May 29 14:38:34 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 29 14:38:34 volumio-jonas volumio[1111]: info: Getting webradio selection May 29 14:38:34 volumio-jonas volumio[1111]: info: Preload queue cleared May 29 14:38:42 volumio-jonas systemd[1]: systemd-timedated.service: Deactivated successfully. May 29 14:38:45 volumio-jonas volumio[1111]: Searching plugin music_service/webradio May 29 14:38:45 volumio-jonas volumio[1111]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 29 14:38:45 volumio-jonas volumio[1111]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 14:38:45 volumio-jonas volumio[1111]: TypeError: Cannot read properties of undefined (reading 'length') May 29 14:38:45 volumio-jonas volumio[1111]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:186:126 May 29 14:38:45 volumio-jonas volumio[1111]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49) May 29 14:38:45 volumio-jonas volumio[1111]: at /volumio/app/plugins/music_service/webradio/index.js:949:31 May 29 14:38:45 volumio-jonas volumio[1111]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) May 29 14:38:45 volumio-jonas volumio[1111]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 14:38:46 volumio-jonas sudo[2903]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-29 14:37' May 29 14:38:46 volumio-jonas sudo[2903]: 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="1da895bfdbb6eb90d965df32a25a3568df7c84ed" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed May 28 19:10:18 UTC 2025" VOLUMIO_VERSION="4.003" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1bd40b20372a0e1ffe6ebc6d3df45570"