Dec 07 23:04:02 volumio volumio[3221]: Searching all installed plugins Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Dec 07 23:04:02 volumio volumio[3221]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: webradio , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: bandcamp , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: jellyfin , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: rad357pl , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: spop , search Dec 07 23:04:02 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Dec 07 23:04:03 volumio volumio[3221]: info: [1765170243108] ControllerCalmRadio::searchCategories Dec 07 23:04:03 volumio volumio[3221]: info: [1765170243110] ControllerCalmRadio::searchChannels Dec 07 23:04:03 volumio volumio[3221]: info: searchQOBUZUri took 530 milliseconds Dec 07 23:04:04 volumio volumio[3221]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 07 23:04:04 volumio volumio[3221]: command_run: { startIndex: 0, length: 76, onTap: { innertubeCommand: [Object] } }, Dec 07 23:04:04 volumio volumio[3221]: input_data: { Dec 07 23:04:04 volumio volumio[3221]: content: "Bitter Sweet Symphony - The Verve / Rockin'1000 That's Live Official · 7:43", Dec 07 23:04:04 volumio volumio[3221]: commandRuns: [ [Object] ] Dec 07 23:04:04 volumio volumio[3221]: }, Dec 07 23:04:04 volumio volumio[3221]: parsed_runs: [ Dec 07 23:04:04 volumio volumio[3221]: { Dec 07 23:04:04 volumio volumio[3221]: text: "Bitter Sweet Symphony - The Verve / Rockin'1000 That's Live Official · 7:43", Dec 07 23:04:04 volumio volumio[3221]: startIndex: 0 Dec 07 23:04:04 volumio volumio[3221]: } Dec 07 23:04:04 volumio volumio[3221]: ] Dec 07 23:04:04 volumio volumio[3221]: } Dec 07 23:04:04 volumio volumio[3221]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 07 23:04:04 volumio volumio[3221]: command_run: { startIndex: 0, length: 60, onTap: { innertubeCommand: [Object] } }, Dec 07 23:04:04 volumio volumio[3221]: input_data: { Dec 07 23:04:04 volumio volumio[3221]: content: "Seven Nation Army / Rockin'1000 That's Live Official · 6:09", Dec 07 23:04:04 volumio volumio[3221]: commandRuns: [ [Object] ] Dec 07 23:04:04 volumio volumio[3221]: }, Dec 07 23:04:04 volumio volumio[3221]: parsed_runs: [ Dec 07 23:04:04 volumio volumio[3221]: { Dec 07 23:04:04 volumio volumio[3221]: text: "Seven Nation Army / Rockin'1000 That's Live Official · 6:09", Dec 07 23:04:04 volumio volumio[3221]: startIndex: 0 Dec 07 23:04:04 volumio volumio[3221]: } Dec 07 23:04:04 volumio volumio[3221]: ] Dec 07 23:04:04 volumio volumio[3221]: } Dec 07 23:04:04 volumio volumio[3221]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 07 23:04:04 volumio volumio[3221]: command_run: { startIndex: 0, length: 75, onTap: { innertubeCommand: [Object] } }, Dec 07 23:04:04 volumio volumio[3221]: input_data: { Dec 07 23:04:04 volumio volumio[3221]: content: "Knights of Cydonia - Muse, played by 1,000 musicians | Rockin'1000 · 11:24", Dec 07 23:04:04 volumio volumio[3221]: commandRuns: [ [Object] ] Dec 07 23:04:04 volumio volumio[3221]: }, Dec 07 23:04:04 volumio volumio[3221]: parsed_runs: [ Dec 07 23:04:04 volumio volumio[3221]: { Dec 07 23:04:04 volumio volumio[3221]: text: "Knights of Cydonia - Muse, played by 1,000 musicians | Rockin'1000 · 11:24", Dec 07 23:04:04 volumio volumio[3221]: startIndex: 0 Dec 07 23:04:04 volumio volumio[3221]: } Dec 07 23:04:04 volumio volumio[3221]: ] Dec 07 23:04:04 volumio volumio[3221]: } Dec 07 23:04:04 volumio volumio[3221]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { Dec 07 23:04:04 volumio volumio[3221]: command_run: { startIndex: 0, length: 71, onTap: { innertubeCommand: [Object] } }, Dec 07 23:04:04 volumio volumio[3221]: input_data: { Dec 07 23:04:04 volumio volumio[3221]: content: "Won't Get Fooled Again - The Who / Rockin'1000 at Milano-Linate · 6:42", Dec 07 23:04:04 volumio volumio[3221]: commandRuns: [ [Object] ] Dec 07 23:04:04 volumio volumio[3221]: }, Dec 07 23:04:04 volumio volumio[3221]: parsed_runs: [ Dec 07 23:04:04 volumio volumio[3221]: { Dec 07 23:04:04 volumio volumio[3221]: text: "Won't Get Fooled Again - The Who / Rockin'1000 at Milano-Linate · 6:42", Dec 07 23:04:04 volumio volumio[3221]: startIndex: 0 Dec 07 23:04:04 volumio volumio[3221]: } Dec 07 23:04:04 volumio volumio[3221]: ] Dec 07 23:04:04 volumio volumio[3221]: } Dec 07 23:04:04 volumio volumio[3221]: info: All search sources collected, pushing search results Dec 07 23:04:06 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:07 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::ClearQueue Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::serviceStop Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::serviceStop Dec 07 23:04:07 volumio volumio[3221]: ------------------------------------ BT MESSAGE: [FUNC] stop Dec 07 23:04:07 volumio volumio[3221]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Dec 07 23:04:07 volumio volumio[3221]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::clearPlayQueue Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::addQueueItems Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::addQueueItems Dec 07 23:04:07 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:07 volumio volumio[3221]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:07 volumio volumio[3221]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D in service youtube2 Dec 07 23:04:07 volumio volumio[3221]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:07 volumio volumio[3221]: ------------------------------------ BT MESSAGE: Bluetooth audio output stopped Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioPlay Dec 07 23:04:07 volumio volumio[3221]: verbose: UNSET VOLATILE: Service: bluetooth Dec 07 23:04:07 volumio volumio[3221]: ------------------------------------ BT MESSAGE: [FUNC] detachBluetooth Dec 07 23:04:07 volumio volumio[3221]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Dec 07 23:04:07 volumio volumio[3221]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::play index 0 Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:07 volumio volumio[3221]: ------------------------------------ BT MESSAGE: Bluetooth audio output disabled. Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::resetVolumioState Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::getcurrentVolume Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioRetrievevolume Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::play index undefined Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioStop Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::startPlaybackTimer Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioGetVisibleSources Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 07 23:04:07 volumio volumio[3221]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:07 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlVDEmjsTKxfEUMs7FEnGijmUa0AiCCgxj4vQGEqhQBcWCEU1NSARM--JMrWxNG5ZDI-Q5RaAk493HYeE-37jbFcs_qP2Wx5GP00ZDAW5KTo30SMg3iA Dec 07 23:04:07 volumio volumio[3221]: info: VolumeController:: Volume=69 Mute =false Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:07 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:07 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:07 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:07 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:07 volumio volumio[3221]: info: CoreCommandRouter::volumioRetrievevolume Dec 07 23:04:07 volumio volumio[3221]: info: FusionDsp - Volumio is not playing Dec 07 23:04:07 volumio volumio[3221]: info: FusionDsp - Clipped samples monitor stopped Dec 07 23:04:07 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:07 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:07 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:07 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:08 volumio volumio[3221]: info: VolumeController:: Volume=69 Mute =false Dec 07 23:04:08 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:08 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:08 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:08 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:08 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:08 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:08 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:08 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:08 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:08 volumio volumio[3221]: info: FusionDsp - Volumio is not playing Dec 07 23:04:08 volumio volumio[3221]: info: FusionDsp - Clipped samples monitor stopped Dec 07 23:04:08 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:08 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:08 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:08 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:08 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlWnpEl2F-1lA6eazct8WxL0tRshEnvh_CzL9kCw3kFmSsWi9U7bBfWswHz3Xor4XiDa9bXAWQ8HzpKoMnegzItOV0yuQzc4Iu_6Min_Tho5DJCfVIRy Dec 07 23:04:08 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): validating stream URL "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191848&ei=SFw2ae36CbuZ-coPhIO2iA8&ip=24.220.196.190&id=o-ADpmV-Dhsltn6GwDlGfv816L6G__LHoJClK97ZN2KIVw&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=237&met=1765170248%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3DweEe3hxOoa_WcHxY3mhDf3miokOdhabiW0QjokGS1sL8eDWsAv9pIimxQTrk_A26D0Z6u6gdQ&spc=wH4Qq-SajRDi5cqBGBLJE9lSLbaOdwnd3ImYMg1gMOFaxNCXr2S6NQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=kgsPCg0yucfLHVxHUERGeZMQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=TLCSYvIeNmN_JQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANFuJsYYQ--B9FNFvINAmhODdY78a_bqcm-yCH8BGEPbAiEAqFZ7CMgLIFh6IrytfyzFo7E9vUIrtysxZjg_F9ZM06E%3D&sig=AJfQdSswRAIgTV2GeY5yOAvNaumoZfKnZzhVW4DjB9Bao9UPmeuwtawCIAkWTsAA5JE91M02tH9TYh3ouIs8hnFJ2gbP2sF9tkqO&pot=MlWnpEl2F-1lA6eazct8WxL0tRshEnvh_CzL9kCw3kFmSsWi9U7bBfWswHz3Xor4XiDa9bXAWQ8HzpKoMnegzItOV0yuQzc4Iu_6Min_Tho5DJCfVIRy&cver=1.20250219.01.00"... Dec 07 23:04:08 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): stream validated in 0.051s. Dec 07 23:04:08 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Added volumioStateListener Dec 07 23:04:08 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Enabled Dec 07 23:04:08 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:08 volumio volumio[3221]: info: sendMpdCommand stop took 2 milliseconds Dec 07 23:04:08 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 23:04:08 volumio volumio[3221]: info: Dec 07 23:04:08 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:08 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:08 volumio volumio[3221]: info: sendMpdCommand clear took 2 milliseconds Dec 07 23:04:08 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191848&ei=SFw2ae36CbuZ-coPhIO2iA8&ip=24.220.196.190&id=o-ADpmV-Dhsltn6GwDlGfv816L6G__LHoJClK97ZN2KIVw&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=237&met=1765170248%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3DweEe3hxOoa_WcHxY3mhDf3miokOdhabiW0QjokGS1sL8eDWsAv9pIimxQTrk_A26D0Z6u6gdQ&spc=wH4Qq-SajRDi5cqBGBLJE9lSLbaOdwnd3ImYMg1gMOFaxNCXr2S6NQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=kgsPCg0yucfLHVxHUERGeZMQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=TLCSYvIeNmN_JQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANFuJsYYQ--B9FNFvINAmhODdY78a_bqcm-yCH8BGEPbAiEAqFZ7CMgLIFh6IrytfyzFo7E9vUIrtysxZjg_F9ZM06E%3D&sig=AJfQdSswRAIgTV2GeY5yOAvNaumoZfKnZzhVW4DjB9Bao9UPmeuwtawCIAkWTsAA5JE91M02tH9TYh3ouIs8hnFJ2gbP2sF9tkqO&pot=MlWnpEl2F-1lA6eazct8WxL0tRshEnvh_CzL9kCw3kFmSsWi9U7bBfWswHz3Xor4XiDa9bXAWQ8HzpKoMnegzItOV0yuQzc4Iu_6Min_Tho5DJCfVIRy&cver=1.20250219.01.00&t.YouTube" Dec 07 23:04:08 volumio volumio[3221]: error: updateQueue error: null Dec 07 23:04:08 volumio volumio[3221]: info: Dec 07 23:04:08 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:08 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:08 volumio volumio[3221]: info: ------------------------------ 6ms Dec 07 23:04:08 volumio volumio[3221]: info: sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191848&ei=SFw2ae36CbuZ-coPhIO2iA8&ip=24.220.196.190&id=o-ADpmV-Dhsltn6GwDlGfv816L6G__LHoJClK97ZN2KIVw&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=237&met=1765170248%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3DweEe3hxOoa_WcHxY3mhDf3miokOdhabiW0QjokGS1sL8eDWsAv9pIimxQTrk_A26D0Z6u6gdQ&spc=wH4Qq-SajRDi5cqBGBLJE9lSLbaOdwnd3ImYMg1gMOFaxNCXr2S6NQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=kgsPCg0yucfLHVxHUERGeZMQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=TLCSYvIeNmN_JQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANFuJsYYQ--B9FNFvINAmhODdY78a_bqcm-yCH8BGEPbAiEAqFZ7CMgLIFh6IrytfyzFo7E9vUIrtysxZjg_F9ZM06E%3D&sig=AJfQdSswRAIgTV2GeY5yOAvNaumoZfKnZzhVW4DjB9Bao9UPmeuwtawCIAkWTsAA5JE91M02tH9TYh3ouIs8hnFJ2gbP2sF9tkqO&pot=MlWnpEl2F-1lA6eazct8WxL0tRshEnvh_CzL9kCw3kFmSsWi9U7bBfWswHz3Xor4XiDa9bXAWQ8HzpKoMnegzItOV0yuQzc4Iu_6Min_Tho5DJCfVIRy&cver=1.20250219.01.00&t.YouTube" took 4 milliseconds Dec 07 23:04:08 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:08 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:08 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:08 volumio volumio[3221]: info: Dec 07 23:04:08 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:08 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:08 volumio volumio[3221]: info: ------------------------------ 6ms Dec 07 23:04:08 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:08 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand play Dec 07 23:04:08 volumio volumio[3221]: info: ------------------------------ 3ms Dec 07 23:04:08 volumio volumio[3221]: info: sendMpdCommand play took 2 milliseconds Dec 07 23:04:09 volumio volumio[3221]: info: Dec 07 23:04:09 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:09 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:09 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:09 volumio volumio[3221]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Dec 07 23:04:09 volumio volumio[3221]: info: FusionDsp - ---- read samplerate from file: 48000 Dec 07 23:04:09 volumio volumio[3221]: info: camilladsp stopping service pid 3807... Dec 07 23:04:09 volumio volumio[3221]: grep: /proc/3807/cmdline: binary file matches Dec 07 23:04:09 volumio volumio[3221]: info: camilladsp service terminated, instance 1 Dec 07 23:04:09 volumio volumio[3221]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 07 23:04:09 volumio volumio[3221]: info: FusionDsp - Effects disabled Dec 07 23:04:09 volumio volumio[3221]: info: camilladsp service started and running in background, instance 1 Dec 07 23:04:09 volumio volumio[3221]: info: Dec 07 23:04:09 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:09 volumio volumio[3221]: info: sendMpdCommand status took 142 milliseconds Dec 07 23:04:09 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:09 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:09 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:09 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:09 volumio volumio[3221]: info: sendMpdCommand status took 7 milliseconds Dec 07 23:04:09 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 07 23:04:09 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:09 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:09 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:09 volumio volumio[3221]: info: ControllerMpd::pushState Dec 07 23:04:09 volumio volumio[3221]: info: CoreCommandRouter::servicePushState Dec 07 23:04:09 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:09 volumio volumio[3221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":463,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bitter Sweet Symphony - The Verve / Rockin'1000 That's Live Official","artist":"Rockin'1000","album":"YouTube","uri":"https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191848&ei=SFw2ae36CbuZ-coPhIO2iA8&ip=24.220.196.190&id=o-ADpmV-Dhsltn6GwDlGfv816L6G__LHoJClK97ZN2KIVw&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=237&met=1765170248%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3DweEe3hxOoa_WcHxY3mhDf3miokOdhabiW0QjokGS1sL8eDWsAv9pIimxQTrk_A26D0Z6u6gdQ&spc=wH4Qq-SajRDi5cqBGBLJE9lSLbaOdwnd3ImYMg1gMOFaxNCXr2S6NQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=kgsPCg0yucfLHVxHUERGeZMQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=TLCSYvIeNmN_JQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANFuJsYYQ--B9FNFvINAmhODdY78a_bqcm-yCH8BGEPbAiEAqFZ7CMgLIFh6IrytfyzFo7E9vUIrtysxZjg_F9ZM06E%3D&sig=AJfQdSswRAIgTV2GeY5yOAvNaumoZfKnZzhVW4DjB9Bao9UPmeuwtawCIAkWTsAA5JE91M02tH9TYh3ouIs8hnFJ2gbP2sF9tkqO&pot=MlWnpEl2F-1lA6eazct8WxL0tRshEnvh_CzL9kCw3kFmSsWi9U7bBfWswHz3Xor4XiDa9bXAWQ8HzpKoMnegzItOV0yuQzc4Iu_6Min_Tho5DJCfVIRy&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 07 23:04:09 volumio volumio[3221]: verbose: CURRENT POSITION 0 Dec 07 23:04:09 volumio volumio[3221]: info: CoreStateMachine::syncState stateService play Dec 07 23:04:09 volumio volumio[3221]: info: CoreStateMachine::syncState currentStatus stop Dec 07 23:04:09 volumio volumio[3221]: info: ------------------------------ 159ms Dec 07 23:04:09 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 07 23:04:09 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:09 volumio volumio[3221]: info: ControllerMpd::pushState Dec 07 23:04:09 volumio volumio[3221]: info: CoreCommandRouter::servicePushState Dec 07 23:04:09 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:09 volumio volumio[3221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1491,"duration":463,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bitter Sweet Symphony - The Verve / Rockin'1000 That's Live Official","artist":"Rockin'1000","album":"YouTube","uri":"https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191848&ei=SFw2ae36CbuZ-coPhIO2iA8&ip=24.220.196.190&id=o-ADpmV-Dhsltn6GwDlGfv816L6G__LHoJClK97ZN2KIVw&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=237&met=1765170248%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3DweEe3hxOoa_WcHxY3mhDf3miokOdhabiW0QjokGS1sL8eDWsAv9pIimxQTrk_A26D0Z6u6gdQ&spc=wH4Qq-SajRDi5cqBGBLJE9lSLbaOdwnd3ImYMg1gMOFaxNCXr2S6NQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=kgsPCg0yucfLHVxHUERGeZMQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=TLCSYvIeNmN_JQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANFuJsYYQ--B9FNFvINAmhODdY78a_bqcm-yCH8BGEPbAiEAqFZ7CMgLIFh6IrytfyzFo7E9vUIrtysxZjg_F9ZM06E%3D&sig=AJfQdSswRAIgTV2GeY5yOAvNaumoZfKnZzhVW4DjB9Bao9UPmeuwtawCIAkWTsAA5JE91M02tH9TYh3ouIs8hnFJ2gbP2sF9tkqO&pot=MlWnpEl2F-1lA6eazct8WxL0tRshEnvh_CzL9kCw3kFmSsWi9U7bBfWswHz3Xor4XiDa9bXAWQ8HzpKoMnegzItOV0yuQzc4Iu_6Min_Tho5DJCfVIRy&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 07 23:04:09 volumio volumio[3221]: verbose: CURRENT POSITION 0 Dec 07 23:04:09 volumio volumio[3221]: info: CoreStateMachine::syncState stateService play Dec 07 23:04:09 volumio volumio[3221]: info: CoreStateMachine::syncState currentStatus play Dec 07 23:04:09 volumio volumio[3221]: info: Received an update from plugin. extracting info from payload Dec 07 23:04:09 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:09 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:09 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:09 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:09 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:09 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:09 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Added mpdStateListener Dec 07 23:04:09 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:09 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:09 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:09 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:09 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:09 volumio volumio[3221]: info: ------------------------------ 64ms Dec 07 23:04:09 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:04:09 volumio volumio[3221]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 07 23:04:09 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:04:09 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:09 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:09 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:09 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:09 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:09 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:09 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:09 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:09 volumio volumio[3221]: info: FusionDsp - Clipping Monitor started Dec 07 23:04:09 volumio volumio[3221]: info: FusionDsp - Clipping Monitor started Dec 07 23:04:13 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::ClearQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::stPlaybackTimer Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:13 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:13 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::serviceStop Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::serviceStop Dec 07 23:04:13 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Removed mpdStateListener Dec 07 23:04:13 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Removed volumioStateListener Dec 07 23:04:13 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Disabled Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:13 volumio volumio[3221]: info: ControllerMpd::stop Dec 07 23:04:13 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::clearPlayQueue Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::addQueueItems Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::addQueueItems Dec 07 23:04:13 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:13 volumio volumio[3221]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: Using cached record of: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::ClearQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::clearPlayQueue Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::addQueueItems Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::addQueueItems Dec 07 23:04:13 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:13 volumio volumio[3221]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: Using cached record of: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPlay Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::play index 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPlay Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::play index 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::play index undefined Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::play index undefined Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::startPlaybackTimer Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioGetVisibleSources Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 07 23:04:13 volumio volumio[3221]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::startPlaybackTimer Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioGetVisibleSources Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 07 23:04:13 volumio volumio[3221]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::ClearQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::clearPlayQueue Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::addQueueItems Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::addQueueItems Dec 07 23:04:13 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:13 volumio volumio[3221]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: Using cached record of: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::ClearQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::clearPlayQueue Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:13 volumio volumio[3221]: info: CoreStateMachine::addQueueItems Dec 07 23:04:13 volumio volumio[3221]: info: CorePlayQueue::addQueueItems Dec 07 23:04:13 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:13 volumio volumio[3221]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:13 volumio volumio[3221]: info: Using cached record of: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioPlay Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::play index 0 Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioPlay Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::play index 0 Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::play index undefined Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::play index undefined Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::startPlaybackTimer Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioGetVisibleSources Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::startPlaybackTimer Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioGetVisibleSources Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBYoVs5WnUHlYTrvkkA_qObX3Crpw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAHAAQGqAxh0aGUgdmVydmUgMTAwMCBtdXNpY2lhbnO6Aw8SDVJEaUVfQ0dDOExHVVG6AwoI8re-_rzqhp1NugMKCKW-pNaJmYPoXboDJBIiUExWQ2RlWUZtRm5xTlZOMHZWblhkamxLNGszTHlzWjhEdLoDCgix2NnRl5Owxia6AwoIiMKJpav595EcugMLCN-wucKMqNuywgG6AwsIvpfAlcraq67WAboDCgi71N-kkcTa2Em6AwoIvdr__N_PyJgYugMKCKfGv46TwcXkDLoDCgiEzfe1wZmF7gG6AwsIy4K6_OKTy9DFAboDCgiNu5qMmvXLr1K6AwsIupzQ9sjwg-qHAboDCwj5paj6_N6o5-8BugMKCODRwL33seG4LroDCwjlhISqqICwn_8BugMKCO_e2Pfy-YL-A_IDBQ1ECYA8uAUB%22%7D%7D%7D Dec 07 23:04:14 volumio volumio[3221]: info: FusionDsp - Volumio is not playing Dec 07 23:04:14 volumio volumio[3221]: info: FusionDsp - Clipped samples monitor stopped Dec 07 23:04:14 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:14 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:14 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:14 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:14 volumio volumio[3221]: info: Dec 07 23:04:14 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:14 volumio volumio[3221]: info: sendMpdCommand stop took 121 milliseconds Dec 07 23:04:14 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:14 volumio volumio[3221]: info: sendMpdCommand status took 3 milliseconds Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:14 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:14 volumio volumio[3221]: info: ControllerMpd::pushState Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::servicePushState Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:14 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:14 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:14 volumio volumio[3221]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 07 23:04:14 volumio volumio[3221]: info: ------------------------------ 36ms Dec 07 23:04:14 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlUzVKMjWl_pcDNqJ54x6Z6HIevLRzZTcF9fBqrlk_PqOVFSHxuWt3nfVIwdC8dK0lNOBV-VFL2LvQZY2CLtfgc9w7xEFnqKrpw5hLQXyhzoeT0HApNf Dec 07 23:04:14 volumio volumio[3221]: info: FusionDsp - Volumio is not playing Dec 07 23:04:14 volumio volumio[3221]: info: FusionDsp - Clipped samples monitor stopped Dec 07 23:04:14 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:14 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:14 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:14 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:14 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlUpNC0mg4sBHikKqZvoPXbpO4tFQu-HmDFFZiTgSicCV0sykR5PY5GxTuyTDh6eOj1UZdGQzWlj0xw4Vic0qu9T2dzKE6NeRvKQS0E1TEYmNAebZ6Bd Dec 07 23:04:14 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlWKoY2-ciw9PIqfCQMZmkrLmB7l2h4gpBPm84R4u4A-deinMYa-xK2T7Xkzlu85Bh_38HEIPM5f8b-t9r_FDdNxeklqi1L5etD0X3qBE1Dja1rmHUHj Dec 07 23:04:14 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlWmzu0A8EL6wqbwab2b9I01tHGFZJxOY-3KnOTGOe75i8TIUTg8qmptwRZTKG1XweHbnxG2vqCYD5PClgFHYxSPViYKNdCXvS4U6GJRxTwGZX65F7Oy Dec 07 23:04:14 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::ClearQueue Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::clearPlayQueue Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:14 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::addQueueItems Dec 07 23:04:14 volumio volumio[3221]: info: CorePlayQueue::addQueueItems Dec 07 23:04:14 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:14 volumio volumio[3221]: info: Adding Item to queue: youtube2/search@query=the%20verve%201000%20musicians/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OALAAQE%253D%22%7D%7D%7D Dec 07 23:04:14 volumio volumio[3221]: info: Exploding uri youtube2/search@query=the%20verve%201000%20musicians/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OALAAQE%253D%22%7D%7D%7D in service youtube2 Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2-browse] explodeUri: youtube2/search@query=the%20verve%201000%20musicians/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OALAAQE%253D%22%7D%7D%7D Dec 07 23:04:14 volumio go-librespot[3454]: time="2025-12-07T23:04:14-06:00" level=trace msg="received accesspoint ping" Dec 07 23:04:14 volumio go-librespot[3454]: time="2025-12-07T23:04:14-06:00" level=trace msg="received accesspoint pong ack" Dec 07 23:04:14 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlUDukN83PcW1QOEx8G3QWEiEQUrGLD7j_pv6Eq6FVsVnGG8_0QQH4Z6ZGL9VEHiLfZ-67_KkhV0GDa2OH1r1viY81KkSfwiUTlk-bReI_PzH5WsRB5f Dec 07 23:04:14 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlVOoSFfGiemm06fpeJxkdFsXB5JO3YrP7Qi8yiZ04ul0iynnWfWzzY0KXmfd4cynbgz8N3pVMXEVnutWl6tBkjWvknGajry4XeWf52UuI93MojXZ8Tf Dec 07 23:04:14 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlWusRUM1J3m_a6PkbG_K5EKvA59aLiRf9LC4xzKHTHltMy3qTQYdXZSyWmrJEmI3d7T4Om6mn-EMJu9bg1jvAiwXlnyOfRIoRFkWhHnPjGWnMPam6VV Dec 07 23:04:14 volumio go-librespot[3454]: time="2025-12-07T23:04:14-06:00" level=trace msg="sent dealer ping" Dec 07 23:04:14 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlXDwoupqwml4cP8DxTAv9IW0X3jzccFPM6vkIJvYqWmqKHEN5Fn4TVOpBo1gTYcnsK-k3cf5evHLPbO8KgcKEusMypsnIvc4g2MQoAVVnERrxAwNMiM Dec 07 23:04:14 volumio go-librespot[3454]: time="2025-12-07T23:04:14-06:00" level=trace msg="received dealer pong" Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): validating stream URL "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2aeG6HaGW2_gPsZi7-AE&ip=208.107.69.15&id=o-AKcb1PSkabHOFLS3XQQH3ZmfJgPVUulGRzRzv1MuRbEL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=285&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3D51pcIkxJS4gXWlaJl9zv2PiWrTV0foF0mi6ugmIHdlTLEfN1F9lyq61LCMLCOKJV-3ogHk87J&spc=wH4Qq7lh2hgNpkIXPclds2Fyac-VgrwM0MUofFdFr82SfFWQbtK4mA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=uIDQ8wCd2G-79XerWTLWM28Q&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=GUzY9ynJjK7Sng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgAjrMz8xlTkNaVXb1lW956ubVZADSsWTBTZrxpcZHyocCICGTQDYYceQVV8nJzGkpweWECpT0aTsGRVv97g2BZEBi&sig=AJfQdSswRQIgYhci4gm-Km-7zGpg-tCe1S-jvjyyzg9N1jnzXGvN1l0CIQC91xlSaUue-wKNcig_HiQPKX08qB72gX1zBo-KIBjOSw%3D%3D&pot=MlUDukN83PcW1QOEx8G3QWEiEQUrGLD7j_pv6Eq6FVsVnGG8_0QQH4Z6ZGL9VEHiLfZ-67_KkhV0GDa2OH1r1viY81KkSfwiUTlk-bReI_PzH5WsRB5f&cver=1.20250219.01.00"... Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): stream validated in 0.071s. Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Added volumioStateListener Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Enabled Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:14 volumio volumio[3221]: info: sendMpdCommand stop took 3 milliseconds Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 23:04:14 volumio volumio[3221]: info: Dec 07 23:04:14 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:14 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:14 volumio volumio[3221]: info: sendMpdCommand clear took 4 milliseconds Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2aeG6HaGW2_gPsZi7-AE&ip=208.107.69.15&id=o-AKcb1PSkabHOFLS3XQQH3ZmfJgPVUulGRzRzv1MuRbEL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=285&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3D51pcIkxJS4gXWlaJl9zv2PiWrTV0foF0mi6ugmIHdlTLEfN1F9lyq61LCMLCOKJV-3ogHk87J&spc=wH4Qq7lh2hgNpkIXPclds2Fyac-VgrwM0MUofFdFr82SfFWQbtK4mA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=uIDQ8wCd2G-79XerWTLWM28Q&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=GUzY9ynJjK7Sng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgAjrMz8xlTkNaVXb1lW956ubVZADSsWTBTZrxpcZHyocCICGTQDYYceQVV8nJzGkpweWECpT0aTsGRVv97g2BZEBi&sig=AJfQdSswRQIgYhci4gm-Km-7zGpg-tCe1S-jvjyyzg9N1jnzXGvN1l0CIQC91xlSaUue-wKNcig_HiQPKX08qB72gX1zBo-KIBjOSw%3D%3D&pot=MlUDukN83PcW1QOEx8G3QWEiEQUrGLD7j_pv6Eq6FVsVnGG8_0QQH4Z6ZGL9VEHiLfZ-67_KkhV0GDa2OH1r1viY81KkSfwiUTlk-bReI_PzH5WsRB5f&cver=1.20250219.01.00&t.YouTube" Dec 07 23:04:14 volumio volumio[3221]: error: updateQueue error: null Dec 07 23:04:14 volumio volumio[3221]: info: Dec 07 23:04:14 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:14 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:14 volumio volumio[3221]: info: ------------------------------ 5ms Dec 07 23:04:14 volumio volumio[3221]: info: sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2aeG6HaGW2_gPsZi7-AE&ip=208.107.69.15&id=o-AKcb1PSkabHOFLS3XQQH3ZmfJgPVUulGRzRzv1MuRbEL&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=285&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3D51pcIkxJS4gXWlaJl9zv2PiWrTV0foF0mi6ugmIHdlTLEfN1F9lyq61LCMLCOKJV-3ogHk87J&spc=wH4Qq7lh2hgNpkIXPclds2Fyac-VgrwM0MUofFdFr82SfFWQbtK4mA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=uIDQ8wCd2G-79XerWTLWM28Q&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=GUzY9ynJjK7Sng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgAjrMz8xlTkNaVXb1lW956ubVZADSsWTBTZrxpcZHyocCICGTQDYYceQVV8nJzGkpweWECpT0aTsGRVv97g2BZEBi&sig=AJfQdSswRQIgYhci4gm-Km-7zGpg-tCe1S-jvjyyzg9N1jnzXGvN1l0CIQC91xlSaUue-wKNcig_HiQPKX08qB72gX1zBo-KIBjOSw%3D%3D&pot=MlUDukN83PcW1QOEx8G3QWEiEQUrGLD7j_pv6Eq6FVsVnGG8_0QQH4Z6ZGL9VEHiLfZ-67_KkhV0GDa2OH1r1viY81KkSfwiUTlk-bReI_PzH5WsRB5f&cver=1.20250219.01.00&t.YouTube" took 4 milliseconds Dec 07 23:04:14 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:14 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:14 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:14 volumio volumio[3221]: info: Dec 07 23:04:14 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:14 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:14 volumio volumio[3221]: info: ------------------------------ 5ms Dec 07 23:04:14 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand play Dec 07 23:04:14 volumio volumio[3221]: info: ------------------------------ 4ms Dec 07 23:04:14 volumio volumio[3221]: info: sendMpdCommand play took 3 milliseconds Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): validating stream URL "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2afrmINql-coPtPuD0Ao&ip=24.220.196.190&id=o-APhKJ8sjcXpAyUW1ePTOO90zhyQZz7fnWW8oDTqQ5ExH&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=289&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3DXjlJABCRO2wTda-xNOodF2G7TVp80PnvmsBc5JtpI4XIwbRSGBvppVXMkVMihdGMS92m506UI&spc=wH4Qq1NuH1HugR4muanv7XXP6nwmenytVQ6Nc8zOH9V_Qt7kffD63Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=RmYZdlpHjkkWz9FV7uIkWOEQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KcwvLbZAz7w6uA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgN8Oju43MM7lRxsTwJ7jhogKn0Ca9HkzYTKtu4orKgqUCIQD9Zli7Ktzoohf6BTBNFUXQP4ZtxqY9w68QNleq1WVD0g%3D%3D&sig=AJfQdSswRQIgX9bpevK3-sm-rJDlW4LMEtXTg5xe-KmfihYSafuAn-MCIQChRN4DwDdnxbqL7VrKhPAlDvYwBwp88qgfDtKQs0B3WQ%3D%3D&pot=MlVOoSFfGiemm06fpeJxkdFsXB5JO3YrP7Qi8yiZ04ul0iynnWfWzzY0KXmfd4cynbgz8N3pVMXEVnutWl6tBkjWvknGajry4XeWf52UuI93MojXZ8Tf&cver=1.20250219.01.00"... Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): validating stream URL "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2abiCI9LAlu8Pree9yQE&ip=208.107.69.15&id=o-AO5kL5OmeGrBfF3gm24oXpOMZUlrZW9olZER_3GzYc_u&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=243&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3CSBBpfNTOT9ZPgzM_NXMezp1ZWZpz65EiF7Rg_1nIe9HGLrIJwOJpK9r4bxPLDZYiNVwbAYrUq&spc=wH4Qq1kJDB3AfG7CQsV5G-cffL2aQ_wEQhLcK-bN_kXYDur5YpVKJQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=MIfzWJF5jW2teIbBW_NdZMwQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=CsytHIr86B_FXQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgWBiTZZDXG8pmreftxrkyg6no89lGpKwh8lNErslbFw8CIGGgUJYjBqu22vWD70mliCKdg2bnqV9wgGKszYnGj6Vn&sig=AJfQdSswRQIgeiG73Yp5shckohDvzE0QYvFz7WTAWyMGelm2dytMekcCIQCsCS5cO3cpjzf7jR6SHw5xsv4PPSkyi1_dcMqUxdjw2Q%3D%3D&pot=MlXDwoupqwml4cP8DxTAv9IW0X3jzccFPM6vkIJvYqWmqKHEN5Fn4TVOpBo1gTYcnsK-k3cf5evHLPbO8KgcKEusMypsnIvc4g2MQoAVVnERrxAwNMiM&cver=1.20250219.01.00"... Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): validating stream URL "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2afTdIsrE-coP5IbSoQ8&ip=24.220.196.190&id=o-ALgH34-v3ajHBOLYgec8MaE20ozNdnhiSbk0MRBhQET3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=295&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3AHiF6YYxwhl46gaybarjQG4hWt2Hz4Gt3vuNxbeJqeiO-tHcsSLDFK7wVjCDhuEHwG2wVOI-kC&spc=wH4QqxGj_4qXRf9tUPt8alH6oIUt_OYJfnkAxW_lnDSPMKRDz9qufA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=rPhvExxUYLDkdRb_usbAtdIQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=qOYgpP-VkZh1tg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANU1RRjLXyaqIGMiCovHYxmb3cXb6eQMBzXaZ1yYwr-tAiEAxQu5xRKFkyM3k21oz34nPrCaHRS8zRXnf6csS7_fDFI%3D&sig=AJfQdSswRQIgX8LhmDsycX-1Mdj5GLfnpRQO52VYV4SD4HWgD-iIW7cCIQDNW9nDZ9SBhahnaq-OvUyV2yAVgC0OGkc2IrTRLmqYsw%3D%3D&pot=MlWusRUM1J3m_a6PkbG_K5EKvA59aLiRf9LC4xzKHTHltMy3qTQYdXZSyWmrJEmI3d7T4Om6mn-EMJu9bg1jvAiwXlnyOfRIoRFkWhHnPjGWnMPam6VV&cver=1.20250219.01.00"... Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): stream validated in 0.06s. Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Enabled Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): stream validated in 0.068s. Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Enabled Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): stream validated in 0.06s. Dec 07 23:04:14 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Enabled Dec 07 23:04:14 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:15 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:15 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:15 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:15 volumio volumio[3221]: info: CoreCommandRouter::volumioPlay Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::play index 0 Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::play index undefined Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:15 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::startPlaybackTimer Dec 07 23:04:15 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:15 volumio volumio[3221]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Bitter%20Sweet%20Symphony%20-%20The%20Verve%20%2F%20Rockin'1000%20That's%20Live%20Official%22%2C%22artist%22%3A%22Rockin'1000%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FiE_CGC8LGUQ%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLC2N8EYA2Gta_aXlO2pTx2sESDy6w%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22iE_CGC8LGUQ%22%2C%22playlistId%22%3A%22RDiE_CGC8LGUQ%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand stop took 208 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand stop took 177 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand stop took 171 milliseconds Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand status took 14 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand clear took 15 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand clear took 15 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand clear took 16 milliseconds Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2afrmINql-coPtPuD0Ao&ip=24.220.196.190&id=o-APhKJ8sjcXpAyUW1ePTOO90zhyQZz7fnWW8oDTqQ5ExH&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=289&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3DXjlJABCRO2wTda-xNOodF2G7TVp80PnvmsBc5JtpI4XIwbRSGBvppVXMkVMihdGMS92m506UI&spc=wH4Qq1NuH1HugR4muanv7XXP6nwmenytVQ6Nc8zOH9V_Qt7kffD63Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=RmYZdlpHjkkWz9FV7uIkWOEQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KcwvLbZAz7w6uA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgN8Oju43MM7lRxsTwJ7jhogKn0Ca9HkzYTKtu4orKgqUCIQD9Zli7Ktzoohf6BTBNFUXQP4ZtxqY9w68QNleq1WVD0g%3D%3D&sig=AJfQdSswRQIgX9bpevK3-sm-rJDlW4LMEtXTg5xe-KmfihYSafuAn-MCIQChRN4DwDdnxbqL7VrKhPAlDvYwBwp88qgfDtKQs0B3WQ%3D%3D&pot=MlVOoSFfGiemm06fpeJxkdFsXB5JO3YrP7Qi8yiZ04ul0iynnWfWzzY0KXmfd4cynbgz8N3pVMXEVnutWl6tBkjWvknGajry4XeWf52UuI93MojXZ8Tf&cver=1.20250219.01.00&t.YouTube" Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2abiCI9LAlu8Pree9yQE&ip=208.107.69.15&id=o-AO5kL5OmeGrBfF3gm24oXpOMZUlrZW9olZER_3GzYc_u&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=243&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3CSBBpfNTOT9ZPgzM_NXMezp1ZWZpz65EiF7Rg_1nIe9HGLrIJwOJpK9r4bxPLDZYiNVwbAYrUq&spc=wH4Qq1kJDB3AfG7CQsV5G-cffL2aQ_wEQhLcK-bN_kXYDur5YpVKJQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=MIfzWJF5jW2teIbBW_NdZMwQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=CsytHIr86B_FXQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgWBiTZZDXG8pmreftxrkyg6no89lGpKwh8lNErslbFw8CIGGgUJYjBqu22vWD70mliCKdg2bnqV9wgGKszYnGj6Vn&sig=AJfQdSswRQIgeiG73Yp5shckohDvzE0QYvFz7WTAWyMGelm2dytMekcCIQCsCS5cO3cpjzf7jR6SHw5xsv4PPSkyi1_dcMqUxdjw2Q%3D%3D&pot=MlXDwoupqwml4cP8DxTAv9IW0X3jzccFPM6vkIJvYqWmqKHEN5Fn4TVOpBo1gTYcnsK-k3cf5evHLPbO8KgcKEusMypsnIvc4g2MQoAVVnERrxAwNMiM&cver=1.20250219.01.00&t.YouTube" Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2afTdIsrE-coP5IbSoQ8&ip=24.220.196.190&id=o-ALgH34-v3ajHBOLYgec8MaE20ozNdnhiSbk0MRBhQET3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=295&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3AHiF6YYxwhl46gaybarjQG4hWt2Hz4Gt3vuNxbeJqeiO-tHcsSLDFK7wVjCDhuEHwG2wVOI-kC&spc=wH4QqxGj_4qXRf9tUPt8alH6oIUt_OYJfnkAxW_lnDSPMKRDz9qufA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=rPhvExxUYLDkdRb_usbAtdIQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=qOYgpP-VkZh1tg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANU1RRjLXyaqIGMiCovHYxmb3cXb6eQMBzXaZ1yYwr-tAiEAxQu5xRKFkyM3k21oz34nPrCaHRS8zRXnf6csS7_fDFI%3D&sig=AJfQdSswRQIgX8LhmDsycX-1Mdj5GLfnpRQO52VYV4SD4HWgD-iIW7cCIQDNW9nDZ9SBhahnaq-OvUyV2yAVgC0OGkc2IrTRLmqYsw%3D%3D&pot=MlWusRUM1J3m_a6PkbG_K5EKvA59aLiRf9LC4xzKHTHltMy3qTQYdXZSyWmrJEmI3d7T4Om6mn-EMJu9bg1jvAiwXlnyOfRIoRFkWhHnPjGWnMPam6VV&cver=1.20250219.01.00&t.YouTube" Dec 07 23:04:15 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlX4SWPvGtJFhfh351JxZDJy6vYLi3be3KqUG2op035GzJpP39fWOtUqn5Hdx4fHfqaFGJ9ZVDAnSM1FGO6t86vICKGE2joHAmktTZVbPTYNK_pqRyb0 Dec 07 23:04:15 volumio volumio[3221]: error: updateQueue error: null Dec 07 23:04:15 volumio volumio[3221]: error: updateQueue error: null Dec 07 23:04:15 volumio volumio[3221]: error: updateQueue error: null Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 13ms Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 14ms Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 13ms Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2afrmINql-coPtPuD0Ao&ip=24.220.196.190&id=o-APhKJ8sjcXpAyUW1ePTOO90zhyQZz7fnWW8oDTqQ5ExH&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=289&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsrn66&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3DXjlJABCRO2wTda-xNOodF2G7TVp80PnvmsBc5JtpI4XIwbRSGBvppVXMkVMihdGMS92m506UI&spc=wH4Qq1NuH1HugR4muanv7XXP6nwmenytVQ6Nc8zOH9V_Qt7kffD63Q&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=RmYZdlpHjkkWz9FV7uIkWOEQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=5&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KcwvLbZAz7w6uA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIgN8Oju43MM7lRxsTwJ7jhogKn0Ca9HkzYTKtu4orKgqUCIQD9Zli7Ktzoohf6BTBNFUXQP4ZtxqY9w68QNleq1WVD0g%3D%3D&sig=AJfQdSswRQIgX9bpevK3-sm-rJDlW4LMEtXTg5xe-KmfihYSafuAn-MCIQChRN4DwDdnxbqL7VrKhPAlDvYwBwp88qgfDtKQs0B3WQ%3D%3D&pot=MlVOoSFfGiemm06fpeJxkdFsXB5JO3YrP7Qi8yiZ04ul0iynnWfWzzY0KXmfd4cynbgz8N3pVMXEVnutWl6tBkjWvknGajry4XeWf52UuI93MojXZ8Tf&cver=1.20250219.01.00&t.YouTube" took 10 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2abiCI9LAlu8Pree9yQE&ip=208.107.69.15&id=o-AO5kL5OmeGrBfF3gm24oXpOMZUlrZW9olZER_3GzYc_u&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=243&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3CSBBpfNTOT9ZPgzM_NXMezp1ZWZpz65EiF7Rg_1nIe9HGLrIJwOJpK9r4bxPLDZYiNVwbAYrUq&spc=wH4Qq1kJDB3AfG7CQsV5G-cffL2aQ_wEQhLcK-bN_kXYDur5YpVKJQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=MIfzWJF5jW2teIbBW_NdZMwQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=CsytHIr86B_FXQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgWBiTZZDXG8pmreftxrkyg6no89lGpKwh8lNErslbFw8CIGGgUJYjBqu22vWD70mliCKdg2bnqV9wgGKszYnGj6Vn&sig=AJfQdSswRQIgeiG73Yp5shckohDvzE0QYvFz7WTAWyMGelm2dytMekcCIQCsCS5cO3cpjzf7jR6SHw5xsv4PPSkyi1_dcMqUxdjw2Q%3D%3D&pot=MlXDwoupqwml4cP8DxTAv9IW0X3jzccFPM6vkIJvYqWmqKHEN5Fn4TVOpBo1gTYcnsK-k3cf5evHLPbO8KgcKEusMypsnIvc4g2MQoAVVnERrxAwNMiM&cver=1.20250219.01.00&t.YouTube" took 10 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191854&ei=Tlw2afTdIsrE-coP5IbSoQ8&ip=24.220.196.190&id=o-ALgH34-v3ajHBOLYgec8MaE20ozNdnhiSbk0MRBhQET3&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=295&met=1765170254%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4153750&bui=AYUSA3AHiF6YYxwhl46gaybarjQG4hWt2Hz4Gt3vuNxbeJqeiO-tHcsSLDFK7wVjCDhuEHwG2wVOI-kC&spc=wH4QqxGj_4qXRf9tUPt8alH6oIUt_OYJfnkAxW_lnDSPMKRDz9qufA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=rPhvExxUYLDkdRb_usbAtdIQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765169803&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=qOYgpP-VkZh1tg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANU1RRjLXyaqIGMiCovHYxmb3cXb6eQMBzXaZ1yYwr-tAiEAxQu5xRKFkyM3k21oz34nPrCaHRS8zRXnf6csS7_fDFI%3D&sig=AJfQdSswRQIgX8LhmDsycX-1Mdj5GLfnpRQO52VYV4SD4HWgD-iIW7cCIQDNW9nDZ9SBhahnaq-OvUyV2yAVgC0OGkc2IrTRLmqYsw%3D%3D&pot=MlWusRUM1J3m_a6PkbG_K5EKvA59aLiRf9LC4xzKHTHltMy3qTQYdXZSyWmrJEmI3d7T4Om6mn-EMJu9bg1jvAiwXlnyOfRIoRFkWhHnPjGWnMPam6VV&cver=1.20250219.01.00&t.YouTube" took 10 milliseconds Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:15 volumio volumio[3221]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 31ms Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 7ms Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 8ms Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand play Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand play Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand play Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 5ms Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 4ms Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 4ms Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand play took 3 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand play took 4 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand play took 3 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #iE_CGC8LGUQ: MlXYIh8X4Z00Btgcm6qKK0Pxyp13c42RrSm0cBbRKDE3T7okoy8tdaSpv_qhP3yIDyWlc-Ohr39Wy-0uZBZWvNpLKMr4IsFIc-regeVb9toeuF58OAW0 Dec 07 23:04:15 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): validating stream URL "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191855&ei=T1w2aYnIFo2_lu8PpuuQuQg&ip=208.107.69.15&id=o-ABjHJAp685OXeWolLTeer_xu0k_Ogn23UgykKBmLR_p4&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=249&met=1765170255%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3BQD5MCNLR8kGz-NJHPg6SzwSkW3NnTUVcDClh2JBRHlAGn7dPvaRoZnEkK6OOb3O0ZkY8jvFnD&spc=wH4QqwFk2fD8HMvKvX7jT6jiH5ikHxrZF_xc-x-WRuGNgdLKS17grw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=pAE-0i4orJ49bMGnNcGol8sQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=QUJuRMn4j4WTFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKc1Pmtb-eF45QcSR5rihrlVLzcwVNiEEbsf_vi0Ke0yAiEAlv6atvXnZXYexi43aw-qIR-FbuhBuyWSrBmTeN8GZAw%3D&sig=AJfQdSswRQIgTp_eiOg8i_7jMMuaX6rkqoxMbVORZyPvwGRVAHr4LFcCIQCJfcx-LsoUeRcHAhRGk-Ls5DdCYlTXc5t_pYGUVHbFOg%3D%3D&pot=MlXYIh8X4Z00Btgcm6qKK0Pxyp13c42RrSm0cBbRKDE3T7okoy8tdaSpv_qhP3yIDyWlc-Ohr39Wy-0uZBZWvNpLKMr4IsFIc-regeVb9toeuF58OAW0&cver=1.20250219.01.00"... Dec 07 23:04:15 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(iE_CGC8LGUQ): stream validated in 0.046s. Dec 07 23:04:15 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Enabled Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand stop took 6 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand status took 1 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand clear took 1 milliseconds Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191855&ei=T1w2aYnIFo2_lu8PpuuQuQg&ip=208.107.69.15&id=o-ABjHJAp685OXeWolLTeer_xu0k_Ogn23UgykKBmLR_p4&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=249&met=1765170255%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3BQD5MCNLR8kGz-NJHPg6SzwSkW3NnTUVcDClh2JBRHlAGn7dPvaRoZnEkK6OOb3O0ZkY8jvFnD&spc=wH4QqwFk2fD8HMvKvX7jT6jiH5ikHxrZF_xc-x-WRuGNgdLKS17grw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=pAE-0i4orJ49bMGnNcGol8sQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=QUJuRMn4j4WTFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKc1Pmtb-eF45QcSR5rihrlVLzcwVNiEEbsf_vi0Ke0yAiEAlv6atvXnZXYexi43aw-qIR-FbuhBuyWSrBmTeN8GZAw%3D&sig=AJfQdSswRQIgTp_eiOg8i_7jMMuaX6rkqoxMbVORZyPvwGRVAHr4LFcCIQCJfcx-LsoUeRcHAhRGk-Ls5DdCYlTXc5t_pYGUVHbFOg%3D%3D&pot=MlXYIh8X4Z00Btgcm6qKK0Pxyp13c42RrSm0cBbRKDE3T7okoy8tdaSpv_qhP3yIDyWlc-Ohr39Wy-0uZBZWvNpLKMr4IsFIc-regeVb9toeuF58OAW0&cver=1.20250219.01.00&t.YouTube" Dec 07 23:04:15 volumio volumio[3221]: error: updateQueue error: null Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 3ms Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand addid "https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191855&ei=T1w2aYnIFo2_lu8PpuuQuQg&ip=208.107.69.15&id=o-ABjHJAp685OXeWolLTeer_xu0k_Ogn23UgykKBmLR_p4&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=249&met=1765170255%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3BQD5MCNLR8kGz-NJHPg6SzwSkW3NnTUVcDClh2JBRHlAGn7dPvaRoZnEkK6OOb3O0ZkY8jvFnD&spc=wH4QqwFk2fD8HMvKvX7jT6jiH5ikHxrZF_xc-x-WRuGNgdLKS17grw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=pAE-0i4orJ49bMGnNcGol8sQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=QUJuRMn4j4WTFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKc1Pmtb-eF45QcSR5rihrlVLzcwVNiEEbsf_vi0Ke0yAiEAlv6atvXnZXYexi43aw-qIR-FbuhBuyWSrBmTeN8GZAw%3D&sig=AJfQdSswRQIgTp_eiOg8i_7jMMuaX6rkqoxMbVORZyPvwGRVAHr4LFcCIQCJfcx-LsoUeRcHAhRGk-Ls5DdCYlTXc5t_pYGUVHbFOg%3D%3D&pot=MlXYIh8X4Z00Btgcm6qKK0Pxyp13c42RrSm0cBbRKDE3T7okoy8tdaSpv_qhP3yIDyWlc-Ohr39Wy-0uZBZWvNpLKMr4IsFIc-regeVb9toeuF58OAW0&cver=1.20250219.01.00&t.YouTube" took 2 milliseconds Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:15 volumio volumio[3221]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 6ms Dec 07 23:04:15 volumio volumio[3221]: info: Dec 07 23:04:15 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:15 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 3ms Dec 07 23:04:15 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:15 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand play Dec 07 23:04:15 volumio volumio[3221]: info: ------------------------------ 2ms Dec 07 23:04:15 volumio volumio[3221]: info: sendMpdCommand play took 1 milliseconds Dec 07 23:04:16 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:16 volumio volumio[3221]: info: Listing playlists Dec 07 23:04:16 volumio volumio[3221]: info: Listing playlists Dec 07 23:04:16 volumio volumio[3221]: info: Dec 07 23:04:16 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:16 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:16 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:16 volumio volumio[3221]: info: Dec 07 23:04:16 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:16 volumio volumio[3221]: info: sendMpdCommand status took 2 milliseconds Dec 07 23:04:16 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:16 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:16 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:16 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:16 volumio volumio[3221]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Dec 07 23:04:16 volumio volumio[3221]: info: FusionDsp - ---- read samplerate from file: 48000 Dec 07 23:04:16 volumio volumio[3221]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 07 23:04:16 volumio volumio[3221]: info: FusionDsp - Effects disabled Dec 07 23:04:16 volumio volumio[3221]: info: sendMpdCommand status took 9 milliseconds Dec 07 23:04:16 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 07 23:04:16 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:16 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:16 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:16 volumio volumio[3221]: info: ControllerMpd::pushState Dec 07 23:04:16 volumio volumio[3221]: info: CoreCommandRouter::servicePushState Dec 07 23:04:16 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:16 volumio volumio[3221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":463,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bitter Sweet Symphony - The Verve / Rockin'1000 That's Live Official","artist":"Rockin'1000","album":"YouTube","uri":"https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191855&ei=T1w2aYnIFo2_lu8PpuuQuQg&ip=208.107.69.15&id=o-ABjHJAp685OXeWolLTeer_xu0k_Ogn23UgykKBmLR_p4&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=249&met=1765170255%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3BQD5MCNLR8kGz-NJHPg6SzwSkW3NnTUVcDClh2JBRHlAGn7dPvaRoZnEkK6OOb3O0ZkY8jvFnD&spc=wH4QqwFk2fD8HMvKvX7jT6jiH5ikHxrZF_xc-x-WRuGNgdLKS17grw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=pAE-0i4orJ49bMGnNcGol8sQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=QUJuRMn4j4WTFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKc1Pmtb-eF45QcSR5rihrlVLzcwVNiEEbsf_vi0Ke0yAiEAlv6atvXnZXYexi43aw-qIR-FbuhBuyWSrBmTeN8GZAw%3D&sig=AJfQdSswRQIgTp_eiOg8i_7jMMuaX6rkqoxMbVORZyPvwGRVAHr4LFcCIQCJfcx-LsoUeRcHAhRGk-Ls5DdCYlTXc5t_pYGUVHbFOg%3D%3D&pot=MlXYIh8X4Z00Btgcm6qKK0Pxyp13c42RrSm0cBbRKDE3T7okoy8tdaSpv_qhP3yIDyWlc-Ohr39Wy-0uZBZWvNpLKMr4IsFIc-regeVb9toeuF58OAW0&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 07 23:04:16 volumio volumio[3221]: verbose: CURRENT POSITION 0 Dec 07 23:04:16 volumio volumio[3221]: info: CoreStateMachine::syncState stateService play Dec 07 23:04:16 volumio volumio[3221]: info: CoreStateMachine::syncState currentStatus stop Dec 07 23:04:16 volumio volumio[3221]: info: ------------------------------ 16ms Dec 07 23:04:16 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 07 23:04:16 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:16 volumio volumio[3221]: info: ControllerMpd::pushState Dec 07 23:04:16 volumio volumio[3221]: info: CoreCommandRouter::servicePushState Dec 07 23:04:16 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:16 volumio volumio[3221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":463,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bitter Sweet Symphony - The Verve / Rockin'1000 That's Live Official","artist":"Rockin'1000","album":"YouTube","uri":"https://rr1---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191855&ei=T1w2aYnIFo2_lu8PpuuQuQg&ip=208.107.69.15&id=o-ABjHJAp685OXeWolLTeer_xu0k_Ogn23UgykKBmLR_p4&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=249&met=1765170255%2C&mh=qA&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqsknse&ms=au%2Crdu&mv=m&mvi=1&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3BQD5MCNLR8kGz-NJHPg6SzwSkW3NnTUVcDClh2JBRHlAGn7dPvaRoZnEkK6OOb3O0ZkY8jvFnD&spc=wH4QqwFk2fD8HMvKvX7jT6jiH5ikHxrZF_xc-x-WRuGNgdLKS17grw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=pAE-0i4orJ49bMGnNcGol8sQ&rqh=1&gir=yes&clen=7173965&dur=462.501&lmt=1753072700634451&mt=1765170046&fvip=2&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=QUJuRMn4j4WTFQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKc1Pmtb-eF45QcSR5rihrlVLzcwVNiEEbsf_vi0Ke0yAiEAlv6atvXnZXYexi43aw-qIR-FbuhBuyWSrBmTeN8GZAw%3D&sig=AJfQdSswRQIgTp_eiOg8i_7jMMuaX6rkqoxMbVORZyPvwGRVAHr4LFcCIQCJfcx-LsoUeRcHAhRGk-Ls5DdCYlTXc5t_pYGUVHbFOg%3D%3D&pot=MlXYIh8X4Z00Btgcm6qKK0Pxyp13c42RrSm0cBbRKDE3T7okoy8tdaSpv_qhP3yIDyWlc-Ohr39Wy-0uZBZWvNpLKMr4IsFIc-regeVb9toeuF58OAW0&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 07 23:04:16 volumio volumio[3221]: verbose: CURRENT POSITION 0 Dec 07 23:04:16 volumio volumio[3221]: info: CoreStateMachine::syncState stateService play Dec 07 23:04:16 volumio volumio[3221]: info: CoreStateMachine::syncState currentStatus play Dec 07 23:04:16 volumio volumio[3221]: info: Received an update from plugin. extracting info from payload Dec 07 23:04:16 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:16 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:16 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:16 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:16 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:16 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:16 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Added mpdStateListener Dec 07 23:04:16 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:16 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:16 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:16 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:16 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:16 volumio volumio[3221]: info: ------------------------------ 44ms Dec 07 23:04:16 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:04:16 volumio volumio[3221]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 07 23:04:16 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:04:16 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:16 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:16 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:16 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:16 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:16 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:16 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:16 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:16 volumio volumio[3221]: info: FusionDsp - Clipping Monitor started Dec 07 23:04:16 volumio volumio[3221]: info: FusionDsp - Clipping Monitor started Dec 07 23:04:17 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::ClearQueue Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::stPlaybackTimer Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:17 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:17 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::serviceStop Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::serviceStop Dec 07 23:04:17 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Removed mpdStateListener Dec 07 23:04:17 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Removed volumioStateListener Dec 07 23:04:17 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Disabled Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:17 volumio volumio[3221]: info: ControllerMpd::stop Dec 07 23:04:17 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::clearPlayQueue Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::addQueueItems Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::addQueueItems Dec 07 23:04:17 volumio volumio[3221]: info: Preload queue cleared Dec 07 23:04:17 volumio volumio[3221]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Rockin'1000%20%7C%7C%20Bitter%20Sweet%20Simphony%20-%20The%20Verve%20%7C%7C%20That's%20Live%20Frankfurt%202019%22%2C%22artist%22%3A%22Giorgia%20Maina%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FTTobU8_Pm_I%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCE45vBq3s3JMbaiMs8O_OJiL8pOQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22TTobU8_Pm_I%22%2C%22params%22%3A%22qgMYdGhlIHZlcnZlIDEwMDAgbXVzaWNpYW5zugMLCMSyrPiCw_CniAG6Aw8SDVJEaUVfQ0dDOExHVVG6AwoIpb6k1omZg-hdugMkEiJQTFZDZGVZRm1GbnFOVk4wdlZuWGRqbEs0azNMeXNaOER0ugMKCLHY2dGXk7DGJroDCgiIwomlq_n3kRy6AwsI37C5woyo27LCAboDCwi-l8CVytqrrtYBugMKCLvU36SRxNrYSboDCgi92v_838_ImBi6AwoIp8a_jpPBxeQMugMKCITN97XBmYXuAboDCwjLgrr84pPL0MUBugMKCI27moya9cuvUroDCwi6nND2yPCD6ocBugMLCPmlqPr83qjn7wG6AwoI4NHAvfex4bguugMLCOWEhKqogLCf_wG6AwoI797Y9_L5gv4D8gMFDUQJgDw%253D%22%7D%7D%7D Dec 07 23:04:17 volumio volumio[3221]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Rockin'1000%20%7C%7C%20Bitter%20Sweet%20Simphony%20-%20The%20Verve%20%7C%7C%20That's%20Live%20Frankfurt%202019%22%2C%22artist%22%3A%22Giorgia%20Maina%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FTTobU8_Pm_I%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCE45vBq3s3JMbaiMs8O_OJiL8pOQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22TTobU8_Pm_I%22%2C%22params%22%3A%22qgMYdGhlIHZlcnZlIDEwMDAgbXVzaWNpYW5zugMLCMSyrPiCw_CniAG6Aw8SDVJEaUVfQ0dDOExHVVG6AwoIpb6k1omZg-hdugMkEiJQTFZDZGVZRm1GbnFOVk4wdlZuWGRqbEs0azNMeXNaOER0ugMKCLHY2dGXk7DGJroDCgiIwomlq_n3kRy6AwsI37C5woyo27LCAboDCwi-l8CVytqrrtYBugMKCLvU36SRxNrYSboDCgi92v_838_ImBi6AwoIp8a_jpPBxeQMugMKCITN97XBmYXuAboDCwjLgrr84pPL0MUBugMKCI27moya9cuvUroDCwi6nND2yPCD6ocBugMLCPmlqPr83qjn7wG6AwoI4NHAvfex4bguugMLCOWEhKqogLCf_wG6AwoI797Y9_L5gv4D8gMFDUQJgDw%253D%22%7D%7D%7D in service youtube2 Dec 07 23:04:17 volumio volumio[3221]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22Rockin'1000%20%7C%7C%20Bitter%20Sweet%20Simphony%20-%20The%20Verve%20%7C%7C%20That's%20Live%20Frankfurt%202019%22%2C%22artist%22%3A%22Giorgia%20Maina%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FTTobU8_Pm_I%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCE45vBq3s3JMbaiMs8O_OJiL8pOQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22TTobU8_Pm_I%22%2C%22params%22%3A%22qgMYdGhlIHZlcnZlIDEwMDAgbXVzaWNpYW5zugMLCMSyrPiCw_CniAG6Aw8SDVJEaUVfQ0dDOExHVVG6AwoIpb6k1omZg-hdugMkEiJQTFZDZGVZRm1GbnFOVk4wdlZuWGRqbEs0azNMeXNaOER0ugMKCLHY2dGXk7DGJroDCgiIwomlq_n3kRy6AwsI37C5woyo27LCAboDCwi-l8CVytqrrtYBugMKCLvU36SRxNrYSboDCgi92v_838_ImBi6AwoIp8a_jpPBxeQMugMKCITN97XBmYXuAboDCwjLgrr84pPL0MUBugMKCI27moya9cuvUroDCwi6nND2yPCD6ocBugMLCPmlqPr83qjn7wG6AwoI4NHAvfex4bguugMLCOWEhKqogLCf_wG6AwoI797Y9_L5gv4D8gMFDUQJgDw%253D%22%7D%7D%7D Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioPushQueue Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::saveQueue Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::updateTrackBlock Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrackBlock Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioPlay Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::play index 0 Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::stop Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::play index undefined Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::startPlaybackTimer Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioGetVisibleSources Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 07 23:04:17 volumio volumio[3221]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22TTobU8_Pm_I%22%2C%22params%22%3A%22qgMYdGhlIHZlcnZlIDEwMDAgbXVzaWNpYW5zugMLCMSyrPiCw_CniAG6Aw8SDVJEaUVfQ0dDOExHVVG6AwoIpb6k1omZg-hdugMkEiJQTFZDZGVZRm1GbnFOVk4wdlZuWGRqbEs0azNMeXNaOER0ugMKCLHY2dGXk7DGJroDCgiIwomlq_n3kRy6AwsI37C5woyo27LCAboDCwi-l8CVytqrrtYBugMKCLvU36SRxNrYSboDCgi92v_838_ImBi6AwoIp8a_jpPBxeQMugMKCITN97XBmYXuAboDCwjLgrr84pPL0MUBugMKCI27moya9cuvUroDCwi6nND2yPCD6ocBugMLCPmlqPr83qjn7wG6AwoI4NHAvfex4bguugMLCOWEhKqogLCf_wG6AwoI797Y9_L5gv4D8gMFDUQJgDw%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Rockin'1000%20%7C%7C%20Bitter%20Sweet%20Simphony%20-%20The%20Verve%20%7C%7C%20That's%20Live%20Frankfurt%202019%22%2C%22artist%22%3A%22Giorgia%20Maina%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FTTobU8_Pm_I%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCE45vBq3s3JMbaiMs8O_OJiL8pOQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22TTobU8_Pm_I%22%2C%22params%22%3A%22qgMYdGhlIHZlcnZlIDEwMDAgbXVzaWNpYW5zugMLCMSyrPiCw_CniAG6Aw8SDVJEaUVfQ0dDOExHVVG6AwoIpb6k1omZg-hdugMkEiJQTFZDZGVZRm1GbnFOVk4wdlZuWGRqbEs0azNMeXNaOER0ugMKCLHY2dGXk7DGJroDCgiIwomlq_n3kRy6AwsI37C5woyo27LCAboDCwi-l8CVytqrrtYBugMKCLvU36SRxNrYSboDCgi92v_838_ImBi6AwoIp8a_jpPBxeQMugMKCITN97XBmYXuAboDCwjLgrr84pPL0MUBugMKCI27moya9cuvUroDCwi6nND2yPCD6ocBugMLCPmlqPr83qjn7wG6AwoI4NHAvfex4bguugMLCOWEhKqogLCf_wG6AwoI797Y9_L5gv4D8gMFDUQJgDw%253D%22%7D%7D%7D Dec 07 23:04:17 volumio volumio[3221]: info: FusionDsp - Volumio is not playing Dec 07 23:04:17 volumio volumio[3221]: info: FusionDsp - Clipped samples monitor stopped Dec 07 23:04:17 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:17 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:17 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:17 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:17 volumio volumio[3221]: info: Dec 07 23:04:17 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:17 volumio volumio[3221]: info: sendMpdCommand stop took 41 milliseconds Dec 07 23:04:17 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:17 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:17 volumio volumio[3221]: info: sendMpdCommand status took 1 milliseconds Dec 07 23:04:17 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:17 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:17 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #TTobU8_Pm_I: MlVjVl6tG9d72mNo2hBwYQwtcek2yXfb4vUPBFdr0nt4kwFQ4pXXP-t1BI7ghYbCQPkeB6IbVTUZF1ZaJays9pWXk765mDsCPDZUUB8yXmZuDftfRIe7 Dec 07 23:04:17 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 07 23:04:17 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:17 volumio volumio[3221]: info: ControllerMpd::pushState Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::servicePushState Dec 07 23:04:17 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:17 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:17 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:17 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:17 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:17 volumio volumio[3221]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Dec 07 23:04:17 volumio volumio[3221]: info: ------------------------------ 33ms Dec 07 23:04:17 volumio volumio[3221]: info: FusionDsp - Volumio is not playing Dec 07 23:04:17 volumio volumio[3221]: info: FusionDsp - Clipped samples monitor stopped Dec 07 23:04:17 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:17 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:17 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:17 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:18 volumio volumio[3221]: info: [ytmusic] Obtained PO token for video #TTobU8_Pm_I: MlUcTIFjjcwVGhxyBd7memLtDvPpB-HAjDVwHoilRGAWU35KPVtBJIW1e5Q_SxDZLjlhHX3Vwy531ylA-mI67ftX7KRmVq0ZUvYdFryLsX9uxMIWgpOO Dec 07 23:04:18 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(TTobU8_Pm_I): validating stream URL "https://rr2---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191858&ei=Ulw2acLjCPSLlu8PqIWi0As&ip=208.107.69.15&id=o-AKaTruXQM1y1glxm1_4gW1HMRSNi3d1HZYMGI96TBrUh&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=77&met=1765170258%2C&mh=cg&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqskn6z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3Cs6VHrvO0JgAvldmzhhhN5s5OtczFzaCoiJg1EO8VdE8Pt_3SYcW5NYfEdzPYKtjOJOxLTj4NW&spc=wH4Qqxtse8s8RqNocfr_iV6PU9vDMlhWU4uQMPSnMdF9lr3YxLQYrw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=WmrLoq2OoqRKFteojCTB2JgQ&rqh=1&gir=yes&clen=5067867&dur=325.061&lmt=1631418475562497&mt=1765170046&fvip=1&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5311222&n=Y3gMr3x3fiApgQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKYmhM6llVHSnImF5d1BTmdqXto2VbAPWQ4yw4thVWmYAiEAgqahHRBDMEXfyGy7ZQ2F1hGv2UHlYb_uLzW5cT8MOlM%3D&sig=AJfQdSswRQIgRYDlhSXRvS4v3Xv4KDOz4ZRs65tybg3O1dZFuWGAHTICIQDYbWTTl19VIISTLwylzZZ28XuDj5r7JWZ9ihpdLSp0pA%3D%3D&pot=MlUcTIFjjcwVGhxyBd7memLtDvPpB-HAjDVwHoilRGAWU35KPVtBJIW1e5Q_SxDZLjlhHX3Vwy531ylA-mI67ftX7KRmVq0ZUvYdFryLsX9uxMIWgpOO&cver=1.20250219.01.00"... Dec 07 23:04:18 volumio volumio[3221]: info: [youtube2] VideoModel.getInfo(TTobU8_Pm_I): stream validated in 0.048s. Dec 07 23:04:18 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Added volumioStateListener Dec 07 23:04:18 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Enabled Dec 07 23:04:18 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 23:04:18 volumio volumio[3221]: info: sendMpdCommand stop took 1 milliseconds Dec 07 23:04:18 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 23:04:18 volumio volumio[3221]: info: Dec 07 23:04:18 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:18 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:18 volumio volumio[3221]: info: sendMpdCommand clear took 1 milliseconds Dec 07 23:04:18 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191858&ei=Ulw2acLjCPSLlu8PqIWi0As&ip=208.107.69.15&id=o-AKaTruXQM1y1glxm1_4gW1HMRSNi3d1HZYMGI96TBrUh&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=77&met=1765170258%2C&mh=cg&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqskn6z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3Cs6VHrvO0JgAvldmzhhhN5s5OtczFzaCoiJg1EO8VdE8Pt_3SYcW5NYfEdzPYKtjOJOxLTj4NW&spc=wH4Qqxtse8s8RqNocfr_iV6PU9vDMlhWU4uQMPSnMdF9lr3YxLQYrw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=WmrLoq2OoqRKFteojCTB2JgQ&rqh=1&gir=yes&clen=5067867&dur=325.061&lmt=1631418475562497&mt=1765170046&fvip=1&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5311222&n=Y3gMr3x3fiApgQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKYmhM6llVHSnImF5d1BTmdqXto2VbAPWQ4yw4thVWmYAiEAgqahHRBDMEXfyGy7ZQ2F1hGv2UHlYb_uLzW5cT8MOlM%3D&sig=AJfQdSswRQIgRYDlhSXRvS4v3Xv4KDOz4ZRs65tybg3O1dZFuWGAHTICIQDYbWTTl19VIISTLwylzZZ28XuDj5r7JWZ9ihpdLSp0pA%3D%3D&pot=MlUcTIFjjcwVGhxyBd7memLtDvPpB-HAjDVwHoilRGAWU35KPVtBJIW1e5Q_SxDZLjlhHX3Vwy531ylA-mI67ftX7KRmVq0ZUvYdFryLsX9uxMIWgpOO&cver=1.20250219.01.00&t.YouTube" Dec 07 23:04:18 volumio volumio[3221]: error: updateQueue error: null Dec 07 23:04:18 volumio volumio[3221]: info: Dec 07 23:04:18 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:18 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:18 volumio volumio[3221]: info: ------------------------------ 3ms Dec 07 23:04:18 volumio volumio[3221]: info: sendMpdCommand addid "https://rr2---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191858&ei=Ulw2acLjCPSLlu8PqIWi0As&ip=208.107.69.15&id=o-AKaTruXQM1y1glxm1_4gW1HMRSNi3d1HZYMGI96TBrUh&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=77&met=1765170258%2C&mh=cg&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqskn6z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3Cs6VHrvO0JgAvldmzhhhN5s5OtczFzaCoiJg1EO8VdE8Pt_3SYcW5NYfEdzPYKtjOJOxLTj4NW&spc=wH4Qqxtse8s8RqNocfr_iV6PU9vDMlhWU4uQMPSnMdF9lr3YxLQYrw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=WmrLoq2OoqRKFteojCTB2JgQ&rqh=1&gir=yes&clen=5067867&dur=325.061&lmt=1631418475562497&mt=1765170046&fvip=1&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5311222&n=Y3gMr3x3fiApgQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKYmhM6llVHSnImF5d1BTmdqXto2VbAPWQ4yw4thVWmYAiEAgqahHRBDMEXfyGy7ZQ2F1hGv2UHlYb_uLzW5cT8MOlM%3D&sig=AJfQdSswRQIgRYDlhSXRvS4v3Xv4KDOz4ZRs65tybg3O1dZFuWGAHTICIQDYbWTTl19VIISTLwylzZZ28XuDj5r7JWZ9ihpdLSp0pA%3D%3D&pot=MlUcTIFjjcwVGhxyBd7memLtDvPpB-HAjDVwHoilRGAWU35KPVtBJIW1e5Q_SxDZLjlhHX3Vwy531ylA-mI67ftX7KRmVq0ZUvYdFryLsX9uxMIWgpOO&cver=1.20250219.01.00&t.YouTube" took 2 milliseconds Dec 07 23:04:18 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:18 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:18 volumio volumio[3221]: verbose: MPD COMMAND [object Object] Dec 07 23:04:18 volumio volumio[3221]: info: Dec 07 23:04:18 volumio volumio[3221]: ---------------------------- MPD announces system playlist update Dec 07 23:04:18 volumio volumio[3221]: info: Ignoring MPD Status Update Dec 07 23:04:18 volumio volumio[3221]: info: ------------------------------ 3ms Dec 07 23:04:18 volumio volumio[3221]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 23:04:18 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand play Dec 07 23:04:18 volumio volumio[3221]: info: ------------------------------ 2ms Dec 07 23:04:18 volumio volumio[3221]: info: sendMpdCommand play took 1 milliseconds Dec 07 23:04:19 volumio volumio[3221]: info: Dec 07 23:04:19 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:19 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:19 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:19 volumio volumio[3221]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Dec 07 23:04:19 volumio volumio[3221]: info: FusionDsp - ---- read samplerate from file: 48000 Dec 07 23:04:19 volumio volumio[3221]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 07 23:04:19 volumio volumio[3221]: info: FusionDsp - Effects disabled Dec 07 23:04:19 volumio volumio[3221]: info: Dec 07 23:04:19 volumio volumio[3221]: ---------------------------- MPD announces state update: player Dec 07 23:04:19 volumio volumio[3221]: info: sendMpdCommand status took 8 milliseconds Dec 07 23:04:19 volumio volumio[3221]: info: ControllerMpd::getState Dec 07 23:04:19 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand status Dec 07 23:04:19 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:19 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:19 volumio volumio[3221]: info: sendMpdCommand status took 3 milliseconds Dec 07 23:04:19 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 07 23:04:19 volumio volumio[3221]: verbose: ControllerMpd::parseState Dec 07 23:04:19 volumio volumio[3221]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 23:04:19 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:19 volumio volumio[3221]: info: ControllerMpd::pushState Dec 07 23:04:19 volumio volumio[3221]: info: CoreCommandRouter::servicePushState Dec 07 23:04:19 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:19 volumio volumio[3221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Rockin'1000 || Bitter Sweet Simphony - The Verve || That's Live Frankfurt 2019","artist":"Giorgia Maina","album":"YouTube","uri":"https://rr2---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191858&ei=Ulw2acLjCPSLlu8PqIWi0As&ip=208.107.69.15&id=o-AKaTruXQM1y1glxm1_4gW1HMRSNi3d1HZYMGI96TBrUh&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=77&met=1765170258%2C&mh=cg&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqskn6z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3Cs6VHrvO0JgAvldmzhhhN5s5OtczFzaCoiJg1EO8VdE8Pt_3SYcW5NYfEdzPYKtjOJOxLTj4NW&spc=wH4Qqxtse8s8RqNocfr_iV6PU9vDMlhWU4uQMPSnMdF9lr3YxLQYrw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=WmrLoq2OoqRKFteojCTB2JgQ&rqh=1&gir=yes&clen=5067867&dur=325.061&lmt=1631418475562497&mt=1765170046&fvip=1&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5311222&n=Y3gMr3x3fiApgQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKYmhM6llVHSnImF5d1BTmdqXto2VbAPWQ4yw4thVWmYAiEAgqahHRBDMEXfyGy7ZQ2F1hGv2UHlYb_uLzW5cT8MOlM%3D&sig=AJfQdSswRQIgRYDlhSXRvS4v3Xv4KDOz4ZRs65tybg3O1dZFuWGAHTICIQDYbWTTl19VIISTLwylzZZ28XuDj5r7JWZ9ihpdLSp0pA%3D%3D&pot=MlUcTIFjjcwVGhxyBd7memLtDvPpB-HAjDVwHoilRGAWU35KPVtBJIW1e5Q_SxDZLjlhHX3Vwy531ylA-mI67ftX7KRmVq0ZUvYdFryLsX9uxMIWgpOO&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 07 23:04:19 volumio volumio[3221]: verbose: CURRENT POSITION 0 Dec 07 23:04:19 volumio volumio[3221]: info: CoreStateMachine::syncState stateService play Dec 07 23:04:19 volumio volumio[3221]: info: CoreStateMachine::syncState currentStatus stop Dec 07 23:04:19 volumio volumio[3221]: info: ------------------------------ 16ms Dec 07 23:04:19 volumio volumio[3221]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 07 23:04:19 volumio volumio[3221]: verbose: ControllerMpd::parseTrackInfo Dec 07 23:04:19 volumio volumio[3221]: info: ControllerMpd::pushState Dec 07 23:04:19 volumio volumio[3221]: info: CoreCommandRouter::servicePushState Dec 07 23:04:19 volumio volumio[3221]: info: CorePlayQueue::getTrack 0 Dec 07 23:04:19 volumio volumio[3221]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Rockin'1000 || Bitter Sweet Simphony - The Verve || That's Live Frankfurt 2019","artist":"Giorgia Maina","album":"YouTube","uri":"https://rr2---sn-hhp-nujl.googlevideo.com/videoplayback?expire=1765191858&ei=Ulw2acLjCPSLlu8PqIWi0As&ip=208.107.69.15&id=o-AKaTruXQM1y1glxm1_4gW1HMRSNi3d1HZYMGI96TBrUh&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=77&met=1765170258%2C&mh=cg&mm=31%2C29&mn=sn-hhp-nujl%2Csn-vgqskn6z&ms=au%2Crdu&mv=m&mvi=2&pl=23&rms=au%2Cau&initcwndbps=4253750&bui=AYUSA3Cs6VHrvO0JgAvldmzhhhN5s5OtczFzaCoiJg1EO8VdE8Pt_3SYcW5NYfEdzPYKtjOJOxLTj4NW&spc=wH4Qqxtse8s8RqNocfr_iV6PU9vDMlhWU4uQMPSnMdF9lr3YxLQYrw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=WmrLoq2OoqRKFteojCTB2JgQ&rqh=1&gir=yes&clen=5067867&dur=325.061&lmt=1631418475562497&mt=1765170046&fvip=1&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968%2C51669167%2C51673847&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=5311222&n=Y3gMr3x3fiApgQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAKYmhM6llVHSnImF5d1BTmdqXto2VbAPWQ4yw4thVWmYAiEAgqahHRBDMEXfyGy7ZQ2F1hGv2UHlYb_uLzW5cT8MOlM%3D&sig=AJfQdSswRQIgRYDlhSXRvS4v3Xv4KDOz4ZRs65tybg3O1dZFuWGAHTICIQDYbWTTl19VIISTLwylzZZ28XuDj5r7JWZ9ihpdLSp0pA%3D%3D&pot=MlUcTIFjjcwVGhxyBd7memLtDvPpB-HAjDVwHoilRGAWU35KPVtBJIW1e5Q_SxDZLjlhHX3Vwy531ylA-mI67ftX7KRmVq0ZUvYdFryLsX9uxMIWgpOO&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"} Dec 07 23:04:19 volumio volumio[3221]: verbose: CURRENT POSITION 0 Dec 07 23:04:19 volumio volumio[3221]: info: CoreStateMachine::syncState stateService play Dec 07 23:04:19 volumio volumio[3221]: info: CoreStateMachine::syncState currentStatus play Dec 07 23:04:19 volumio volumio[3221]: info: Received an update from plugin. extracting info from payload Dec 07 23:04:19 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:19 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:19 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:19 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:19 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:19 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:19 volumio volumio[3221]: info: [youtube2] (AutoplayManager) Added mpdStateListener Dec 07 23:04:19 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:19 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:19 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:19 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:19 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:19 volumio volumio[3221]: info: ------------------------------ 43ms Dec 07 23:04:19 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:04:19 volumio volumio[3221]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 07 23:04:19 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:04:19 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:19 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:19 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:19 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:19 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Dec 07 23:04:19 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:19 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 69 Dec 07 23:04:19 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:04:19 volumio volumio[3221]: info: FusionDsp - Clipping Monitor started Dec 07 23:04:19 volumio volumio[3221]: info: FusionDsp - Clipping Monitor started Dec 07 23:04:26 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:28 volumio volumio[3221]: info: VolumeController::SetAlsaVolume70 Dec 07 23:04:28 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:28 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:28 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:28 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:28 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:28 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:28 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:28 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:04:28 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 07 23:04:29 volumio volumio[3221]: info: VolumeController::SetAlsaVolume75 Dec 07 23:04:29 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:29 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:04:29 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:04:29 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:04:29 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:04:29 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:04:29 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:29 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:04:29 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Dec 07 23:04:29 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 70 Dec 07 23:04:29 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 75 Dec 07 23:04:29 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 07 23:04:29 volumio volumio[3221]: info: Setting Spotify Volume from Volumio: 75 Dec 07 23:04:30 volumio volumio[3221]: SPOTIFY: SETTING SPOTIFY VOLUME 75 Dec 07 23:04:30 volumio volumio[3221]: info: Sending Spotify command with payload to local API: /player/volume Dec 07 23:04:30 volumio go-librespot[3454]: time="2025-12-07T23:04:30-06:00" level=debug msg="update volume requested to 49151/65535" Dec 07 23:04:30 volumio go-librespot[3454]: time="2025-12-07T23:04:30-06:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 07 23:04:30 volumio go-librespot[3454]: time="2025-12-07T23:04:30-06:00" level=trace msg="emitting websocket event: volume" Dec 07 23:04:30 volumio volumio[3221]: SPOTIFY: received: {"type":"volume","data":{"value":75,"max":100}} Dec 07 23:04:30 volumio volumio[3221]: SPOTIFY: RECEIVED SPOTIFY VOLUME 75 Dec 07 23:04:36 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:36 volumio volumio[3221]: info: Listing playlists Dec 07 23:04:36 volumio volumio[3221]: info: Listing playlists Dec 07 23:04:44 volumio go-librespot[3454]: time="2025-12-07T23:04:44-06:00" level=trace msg="sent dealer ping" Dec 07 23:04:44 volumio go-librespot[3454]: time="2025-12-07T23:04:44-06:00" level=trace msg="received dealer pong" Dec 07 23:04:46 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:56 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:04:56 volumio volumio[3221]: info: Listing playlists Dec 07 23:04:56 volumio volumio[3221]: info: Listing playlists Dec 07 23:05:06 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:14 volumio go-librespot[3454]: time="2025-12-07T23:05:14-06:00" level=trace msg="sent dealer ping" Dec 07 23:05:14 volumio go-librespot[3454]: time="2025-12-07T23:05:14-06:00" level=trace msg="received dealer pong" Dec 07 23:05:16 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:16 volumio volumio[3221]: info: Listing playlists Dec 07 23:05:16 volumio volumio[3221]: info: Listing playlists Dec 07 23:05:24 volumio volumio[3221]: info: VolumeController::SetAlsaVolume80 Dec 07 23:05:24 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:24 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:05:24 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:05:24 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:05:24 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:05:24 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:05:24 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:24 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:05:24 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Dec 07 23:05:24 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 75 Dec 07 23:05:24 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 80 Dec 07 23:05:24 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 07 23:05:24 volumio volumio[3221]: info: Setting Spotify Volume from Volumio: 80 Dec 07 23:05:24 volumio volumio[3221]: info: VolumeController::SetAlsaVolume85 Dec 07 23:05:24 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:24 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:05:24 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:05:24 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:05:24 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:05:24 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:05:24 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:24 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:05:24 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Dec 07 23:05:24 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 80 Dec 07 23:05:24 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 80 Dec 07 23:05:24 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 07 23:05:25 volumio volumio[3221]: SPOTIFY: SETTING SPOTIFY VOLUME 80 Dec 07 23:05:25 volumio volumio[3221]: info: Sending Spotify command with payload to local API: /player/volume Dec 07 23:05:25 volumio go-librespot[3454]: time="2025-12-07T23:05:25-06:00" level=debug msg="update volume requested to 52428/65535" Dec 07 23:05:26 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:26 volumio go-librespot[3454]: time="2025-12-07T23:05:26-06:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 07 23:05:26 volumio go-librespot[3454]: time="2025-12-07T23:05:26-06:00" level=trace msg="emitting websocket event: volume" Dec 07 23:05:26 volumio volumio[3221]: SPOTIFY: received: {"type":"volume","data":{"value":80,"max":100}} Dec 07 23:05:26 volumio volumio[3221]: SPOTIFY: RECEIVED SPOTIFY VOLUME 80 Dec 07 23:05:28 volumio volumio[3221]: info: VolumeController::SetAlsaVolume35 Dec 07 23:05:28 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:28 volumio volumio[3221]: info: CoreStateMachine::pushState Dec 07 23:05:28 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 23:05:28 volumio volumio[3221]: info: CoreCommandRouter::volumioPushState Dec 07 23:05:28 volumio volumio[3221]: info: MRS: Pushing multiroomSync output update for this device Dec 07 23:05:28 volumio volumio[3221]: info: MRS: Pushing multiroomSync output Dec 07 23:05:28 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:28 volumio volumio[3221]: info: FusionDsp - Volumio is playing Dec 07 23:05:28 volumio volumio[3221]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Dec 07 23:05:28 volumio volumio[3221]: SPOTIFY: SPOTIFY VOLUME 80 Dec 07 23:05:28 volumio volumio[3221]: SPOTIFY: VOLUMIO VOLUME 35 Dec 07 23:05:28 volumio volumio[3221]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 07 23:05:28 volumio volumio[3221]: info: Setting Spotify Volume from Volumio: 35 Dec 07 23:05:29 volumio volumio[3221]: SPOTIFY: SETTING SPOTIFY VOLUME 35 Dec 07 23:05:29 volumio volumio[3221]: info: Sending Spotify command with payload to local API: /player/volume Dec 07 23:05:29 volumio go-librespot[3454]: time="2025-12-07T23:05:29-06:00" level=debug msg="update volume requested to 22937/65535" Dec 07 23:05:30 volumio go-librespot[3454]: time="2025-12-07T23:05:30-06:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 07 23:05:30 volumio go-librespot[3454]: time="2025-12-07T23:05:30-06:00" level=trace msg="emitting websocket event: volume" Dec 07 23:05:30 volumio volumio[3221]: SPOTIFY: received: {"type":"volume","data":{"value":35,"max":100}} Dec 07 23:05:30 volumio volumio[3221]: SPOTIFY: RECEIVED SPOTIFY VOLUME 35 Dec 07 23:05:36 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:36 volumio volumio[3221]: info: Listing playlists Dec 07 23:05:36 volumio volumio[3221]: info: Listing playlists Dec 07 23:05:44 volumio go-librespot[3454]: time="2025-12-07T23:05:44-06:00" level=trace msg="sent dealer ping" Dec 07 23:05:44 volumio go-librespot[3454]: time="2025-12-07T23:05:44-06:00" level=trace msg="received dealer pong" Dec 07 23:05:46 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:56 volumio volumio[3221]: info: CoreCommandRouter::volumioGetState Dec 07 23:05:56 volumio volumio[3221]: info: Listing playlists Dec 07 23:05:56 volumio volumio[3221]: info: Listing playlists Dec 07 23:05:58 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Dec 07 23:05:58 volumio volumio[3221]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Dec 07 23:05:58 volumio volumio[3221]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 23:05:58 volumio volumio[3221]: TypeError: Cannot read properties of undefined (reading 'then') Dec 07 23:05:58 volumio volumio[3221]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Dec 07 23:05:58 volumio volumio[3221]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Dec 07 23:05:58 volumio volumio[3221]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1467:26) Dec 07 23:05:58 volumio volumio[3221]: at Socket.emit (node:events:514:28) Dec 07 23:05:58 volumio volumio[3221]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 07 23:05:58 volumio volumio[3221]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 07 23:05:58 volumio volumio[3221]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 23:05:58 volumio sudo[5436]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-07 23:04' Dec 07 23:05:58 volumio sudo[5436]: 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="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 2 11:51:19 UTC 2025" VOLUMIO_VERSION="4.072" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e5001581b220b096097cf8f46a54d4f1"