Oct 13 21:56:00 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service youtube2 showDisclaimer undefined Oct 13 21:56:00 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: youtube2 , showDisclaimer Oct 13 21:56:01 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service youtube2 acceptDisclaimer Oct 13 21:56:01 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: youtube2 , acceptDisclaimer Oct 13 21:56:01 volumiostreamer volumio[1051]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service youtube2 configSaveDisclaimer [object Object] Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: youtube2 , configSaveDisclaimer Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service youtube2 configSaveDisclaimer [object Object] Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: youtube2 , configSaveDisclaimer Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service youtube2 configSaveDisclaimer [object Object] Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: youtube2 , configSaveDisclaimer Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 21:56:12 volumiostreamer volumio[1051]: Upnp client error: Error: This socket has been ended by the other party Oct 13 21:56:12 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri Oct 13 21:56:12 volumiostreamer volumio[1051]: info: [ytmusic-browse] browseUri: ytmusic Oct 13 21:56:19 volumiostreamer volumio[1051]: info: [youtube2] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version Oct 13 21:56:19 volumiostreamer volumio[1051]: info: [youtube2] Innertube support service: Start service with Node Oct 13 21:56:19 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:19 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Oct 13 21:56:19 volumiostreamer volumio[1051]: info: [youtube2-browse] browseUri: youtube2 Oct 13 21:56:19 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri Oct 13 21:56:19 volumiostreamer volumio[1051]: info: [ytmusic-browse] browseUri: ytmusic Oct 13 21:56:19 volumiostreamer volumio[1051]: Upnp client error: Error: This socket has been ended by the other party Oct 13 21:56:20 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:21 volumiostreamer volumio[1051]: Searching plugin music_service/ytmusic Oct 13 21:56:21 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Oct 13 21:56:24 volumiostreamer volumio[1051]: info: [youtube2] Innertube support service: result: {"status":"started","server":{"address":"127.0.0.1","port":34497}} Oct 13 21:56:24 volumiostreamer volumio[1051]: info: [youtube2] Innertube support service running at http://127.0.0.1:34497 Oct 13 21:56:25 volumiostreamer systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Oct 13 21:56:25 volumiostreamer dbus-daemon[561]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.34' (uid=0 pid=3115 comm="timedatectl show --property=NTPSynchronized --valu") Oct 13 21:56:25 volumiostreamer systemd[1]: Starting systemd-timedated.service - Time & Date Service... Oct 13 21:56:26 volumiostreamer dbus-daemon[561]: [system] Successfully activated service 'org.freedesktop.timedate1' Oct 13 21:56:26 volumiostreamer systemd[1]: Started systemd-timedated.service - Time & Date Service. Oct 13 21:56:26 volumiostreamer setdatetime-helper.sh[3114]: Time is not synchronized. Attempting to sync... Oct 13 21:56:26 volumiostreamer sudo[3140]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Tue, 13 Oct 2026 19:56:27 GMT#015' Oct 13 21:56:26 volumiostreamer sudo[3140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 21:56:27 volumiostreamer setdatetime-helper.sh[3141]: Tue Oct 13 21:56:27 CEST 2026 Oct 13 21:56:27 volumiostreamer sudo[3140]: pam_unix(sudo:session): session closed for user root Oct 13 21:56:27 volumiostreamer setdatetime-helper.sh[3114]: Time synchronized successfully. Oct 13 21:56:27 volumiostreamer systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Oct 13 21:56:27 volumiostreamer systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Oct 13 21:56:27 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Oct 13 21:56:27 volumiostreamer volumio[1051]: info: [youtube2-browse] browseUri: youtube2 Oct 13 21:56:31 volumiostreamer volumio[1051]: info: [youtube2] Obtained session PO token using visitorData (expires in 43199 seconds) Oct 13 21:56:31 volumiostreamer volumio[1051]: info: [youtube2] Going to refresh session PO token in 43099 seconds Oct 13 21:56:31 volumiostreamer ntpd[805]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 21:56:31 volumiostreamer ntpd[805]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Oct 13 21:56:31 volumiostreamer ntpd[805]: DNS: Pool skipping: 195.95.153.59 Oct 13 21:56:31 volumiostreamer ntpd[805]: DNS: Pool skipping: 195.95.153.43 Oct 13 21:56:31 volumiostreamer ntpd[805]: DNS: Pool taking: 84.77.195.114 Oct 13 21:56:31 volumiostreamer ntpd[805]: DNS: Pool skipping: 212.227.145.233 Oct 13 21:56:31 volumiostreamer ntpd[805]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Oct 13 21:56:32 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:32 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:32 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:32 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:35 volumiostreamer volumio[1051]: Searching plugin music_service/youtube2 Oct 13 21:56:35 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Oct 13 21:56:36 volumiostreamer volumio[1051]: info: All search sources collected, pushing search results Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::ClearQueue Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::stop Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::stPlaybackTimer Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::updateTrackBlock Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrackBlock Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::serviceStop Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::serviceStop Oct 13 21:56:39 volumiostreamer volumio[1051]: info: [1791921399413] ControllerWebradio::stop Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::clearPlayQueue Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::saveQueue Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushQueue Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::addQueueItems Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::addQueueItems Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Adding Item to queue: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22AC%2FDC%20-%20Highway%20to%20Hell%20(Live%20At%20River%20Plate%2C%20December%202009)%22%2C%22artist%22%3A%22AC%2FDC%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FgEPmA3USJdI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLDPrrftMYalhrEMdBOTdlKk2X3mvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22gEPmA3USJdI%22%2C%22playlistId%22%3A%22RDgEPmA3USJdI%22%2C%22params%22%3A%22wAEBqgMFYWMgZGO6AxwSGlJERU1Eczh2V0lRS01mbEJHOFFVUVFhVXJ3ugMLCLe80J-TpaaHyAG6AwsIvZTTtfem4fifAboDCgie_NPHpsjqxi66AwsI8MeP5baMqfWDAboDCgjjgfS_w-usrWy6AwoItseQiZf9w_4BugMLCM_DkfKP2Yn56gG6AwoI1KeFu-SUguh6ugMLCNbd75_y5ImKxQG6AwsI3qTutLCZscHnAboDCgjCjp2Lsprx5UC6AwoIlMjnwunm29gWugMKCLLusurw5pGTProDCgitkNnTnKT7syS6AwsIrYr-mJGc6P7dAboDCwjVhtSHnoL2wuMBugMKCP746MqIi5-zS7oDCwj90_TLiIbLjJgB8gMFDbfseT24BQE%253D%22%7D%7D%7D Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Exploding uri youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22AC%2FDC%20-%20Highway%20to%20Hell%20(Live%20At%20River%20Plate%2C%20December%202009)%22%2C%22artist%22%3A%22AC%2FDC%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FgEPmA3USJdI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLDPrrftMYalhrEMdBOTdlKk2X3mvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22gEPmA3USJdI%22%2C%22playlistId%22%3A%22RDgEPmA3USJdI%22%2C%22params%22%3A%22wAEBqgMFYWMgZGO6AxwSGlJERU1Eczh2V0lRS01mbEJHOFFVUVFhVXJ3ugMLCLe80J-TpaaHyAG6AwsIvZTTtfem4fifAboDCgie_NPHpsjqxi66AwsI8MeP5baMqfWDAboDCgjjgfS_w-usrWy6AwoItseQiZf9w_4BugMLCM_DkfKP2Yn56gG6AwoI1KeFu-SUguh6ugMLCNbd75_y5ImKxQG6AwsI3qTutLCZscHnAboDCgjCjp2Lsprx5UC6AwoIlMjnwunm29gWugMKCLLusurw5pGTProDCgitkNnTnKT7syS6AwsIrYr-mJGc6P7dAboDCwjVhtSHnoL2wuMBugMKCP746MqIi5-zS7oDCwj90_TLiIbLjJgB8gMFDbfseT24BQE%253D%22%7D%7D%7D in service youtube2 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: [youtube2-browse] explodeUri: youtube2/video@explodeTrackData:o=%7B%22title%22%3A%22AC%2FDC%20-%20Highway%20to%20Hell%20(Live%20At%20River%20Plate%2C%20December%202009)%22%2C%22artist%22%3A%22AC%2FDC%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FgEPmA3USJdI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLDPrrftMYalhrEMdBOTdlKk2X3mvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22gEPmA3USJdI%22%2C%22playlistId%22%3A%22RDgEPmA3USJdI%22%2C%22params%22%3A%22wAEBqgMFYWMgZGO6AxwSGlJERU1Eczh2V0lRS01mbEJHOFFVUVFhVXJ3ugMLCLe80J-TpaaHyAG6AwsIvZTTtfem4fifAboDCgie_NPHpsjqxi66AwsI8MeP5baMqfWDAboDCgjjgfS_w-usrWy6AwoItseQiZf9w_4BugMLCM_DkfKP2Yn56gG6AwoI1KeFu-SUguh6ugMLCNbd75_y5ImKxQG6AwsI3qTutLCZscHnAboDCgjCjp2Lsprx5UC6AwoIlMjnwunm29gWugMKCLLusurw5pGTProDCgitkNnTnKT7syS6AwsIrYr-mJGc6P7dAboDCwjVhtSHnoL2wuMBugMKCP746MqIi5-zS7oDCwj90_TLiIbLjJgB8gMFDbfseT24BQE%253D%22%7D%7D%7D Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushQueue Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::saveQueue Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::updateTrackBlock Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrackBlock Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPlay Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::play index 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::stop Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::play index undefined Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::startPlaybackTimer Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22gEPmA3USJdI%22%2C%22playlistId%22%3A%22RDgEPmA3USJdI%22%2C%22params%22%3A%22wAEBqgMFYWMgZGO6AxwSGlJERU1Eczh2V0lRS01mbEJHOFFVUVFhVXJ3ugMLCLe80J-TpaaHyAG6AwsIvZTTtfem4fifAboDCgie_NPHpsjqxi66AwsI8MeP5baMqfWDAboDCgjjgfS_w-usrWy6AwoItseQiZf9w_4BugMLCM_DkfKP2Yn56gG6AwoI1KeFu-SUguh6ugMLCNbd75_y5ImKxQG6AwsI3qTutLCZscHnAboDCgjCjp2Lsprx5UC6AwoIlMjnwunm29gWugMKCLLusurw5pGTProDCgitkNnTnKT7syS6AwsIrYr-mJGc6P7dAboDCwjVhtSHnoL2wuMBugMKCP746MqIi5-zS7oDCwj90_TLiIbLjJgB8gMFDbfseT24BQE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22AC%2FDC%20-%20Highway%20to%20Hell%20(Live%20At%20River%20Plate%2C%20December%202009)%22%2C%22artist%22%3A%22AC%2FDC%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FgEPmA3USJdI%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLDPrrftMYalhrEMdBOTdlKk2X3mvg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22gEPmA3USJdI%22%2C%22playlistId%22%3A%22RDgEPmA3USJdI%22%2C%22params%22%3A%22wAEBqgMFYWMgZGO6AxwSGlJERU1Eczh2V0lRS01mbEJHOFFVUVFhVXJ3ugMLCLe80J-TpaaHyAG6AwsIvZTTtfem4fifAboDCgie_NPHpsjqxi66AwsI8MeP5baMqfWDAboDCgjjgfS_w-usrWy6AwoItseQiZf9w_4BugMLCM_DkfKP2Yn56gG6AwoI1KeFu-SUguh6ugMLCNbd75_y5ImKxQG6AwsI3qTutLCZscHnAboDCgjCjp2Lsprx5UC6AwoIlMjnwunm29gWugMKCLLusurw5pGTProDCgitkNnTnKT7syS6AwsIrYr-mJGc6P7dAboDCwjVhtSHnoL2wuMBugMKCP746MqIi5-zS7oDCwj90_TLiIbLjJgB8gMFDbfseT24BQE%253D%22%7D%7D%7D Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Oct 13 21:56:39 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand stop took 48 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Oct 13 21:56:39 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Oct 13 21:56:39 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Oct 13 21:56:39 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand status took 9 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand status took 6 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand status took 6 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand status took 4 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:39 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:39 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:39 volumiostreamer volumio[1051]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ------------------------------ 66ms Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ------------------------------ 65ms Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ------------------------------ 62ms Oct 13 21:56:39 volumiostreamer volumio[1051]: info: ------------------------------ 62ms Oct 13 21:56:39 volumiostreamer volumio[1051]: info: [youtube2] Obtained PO token for video #gEPmA3USJdI: MltCih6RAk-d_kLOcGbmloXzwVJTWsA8MIJwWu7gbNE0j5Tpw_oPwmVpl-86xwxbyqldG6hOV5RKnRbGn0mM_2V9KOI9vNI4ksieKVvNsIPXni92WOyaPCMXSaR3 Oct 13 21:56:40 volumiostreamer volumio[1051]: info: [youtube2] Obtained PO token for video #gEPmA3USJdI: MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba Oct 13 21:56:40 volumiostreamer ntpd[805]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 21:56:40 volumiostreamer volumio[1051]: info: [youtube2] Got stream with ANDROID_VR client Oct 13 21:56:40 volumiostreamer volumio[1051]: info: [youtube2] VideoModel.getPlaybackInfo(gEPmA3USJdI): validating stream URL "https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba"... Oct 13 21:56:40 volumiostreamer ntpd[805]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Oct 13 21:56:40 volumiostreamer ntpd[805]: DNS: Pool taking: 162.159.200.123 Oct 13 21:56:40 volumiostreamer ntpd[805]: DNS: Pool taking: 172.233.111.193 Oct 13 21:56:40 volumiostreamer ntpd[805]: DNS: Pool taking: 93.176.187.101 Oct 13 21:56:40 volumiostreamer ntpd[805]: DNS: Pool taking: 94.143.139.219 Oct 13 21:56:40 volumiostreamer ntpd[805]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Oct 13 21:56:40 volumiostreamer volumio[1051]: warn: [youtube2] VideoModel.getPlaybackInfo(gEPmA3USJdI): stream validation failed (403 - Forbidden); retrying after 2s... Oct 13 21:56:41 volumiostreamer volumio[1051]: info: VolumeController::SetAlsaVolume30 Oct 13 21:56:41 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:41 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:41 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 21:56:41 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:43 volumiostreamer volumio[1051]: warn: [youtube2] VideoModel.getPlaybackInfo(gEPmA3USJdI): stream validation failed (403 - Forbidden); retrying after 2s... Oct 13 21:56:43 volumiostreamer ntpd[805]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 21:56:43 volumiostreamer ntpd[805]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Oct 13 21:56:43 volumiostreamer ntpd[805]: DNS: Pool taking: 195.20.235.143 Oct 13 21:56:43 volumiostreamer ntpd[805]: DNS: Pool skipping: 162.159.200.1 Oct 13 21:56:43 volumiostreamer ntpd[805]: DNS: Pool skipping: 185.134.42.7 Oct 13 21:56:43 volumiostreamer ntpd[805]: DNS: Pool skipping: 85.49.251.3 Oct 13 21:56:43 volumiostreamer ntpd[805]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Oct 13 21:56:44 volumiostreamer ntpd[805]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 21:56:44 volumiostreamer ntpd[805]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Oct 13 21:56:44 volumiostreamer ntpd[805]: DNS: Pool skipping: 195.95.153.43 Oct 13 21:56:44 volumiostreamer ntpd[805]: DNS: Pool taking: 172.233.111.111 Oct 13 21:56:44 volumiostreamer ntpd[805]: DNS: Pool skipping: 178.215.228.24 Oct 13 21:56:44 volumiostreamer ntpd[805]: DNS: Pool skipping: 172.233.111.193 Oct 13 21:56:44 volumiostreamer ntpd[805]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Oct 13 21:56:45 volumiostreamer volumio[1051]: warn: [youtube2] VideoModel.getPlaybackInfo(gEPmA3USJdI): stream validation failed (403 - Forbidden); retrying after 2s... Oct 13 21:56:46 volumiostreamer volumio[1051]: info: VolumeController::SetAlsaVolume25 Oct 13 21:56:46 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:46 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:46 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 21:56:46 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:47 volumiostreamer volumio[1051]: warn: [youtube2] VideoModel.getPlaybackInfo(gEPmA3USJdI): failed to validate stream URL "https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba" (retried 3 times in 6.836s). Oct 13 21:56:47 volumiostreamer volumio[1051]: info: [youtube2] (AutoplayManager) Added volumioStateListener Oct 13 21:56:47 volumiostreamer volumio[1051]: info: [youtube2] (AutoplayManager) Enabled Oct 13 21:56:47 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 21:56:47 volumiostreamer volumio[1051]: info: sendMpdCommand stop took 2 milliseconds Oct 13 21:56:47 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand clear Oct 13 21:56:47 volumiostreamer volumio[1051]: info: sendMpdCommand clear took 0 milliseconds Oct 13 21:56:47 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand addid "https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube" Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: sendMpdCommand addid "https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube" took 9 milliseconds Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 8ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 7ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 6ms Oct 13 21:56:47 volumiostreamer volumio[1051]: verbose: MPD COMMAND [object Object] Oct 13 21:56:47 volumiostreamer volumio[1051]: verbose: MPD COMMAND [object Object] Oct 13 21:56:47 volumiostreamer volumio[1051]: verbose: MPD COMMAND [object Object] Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 15ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 14ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 8ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 7ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 6ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 13 21:56:47 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand play Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Oct 13 21:56:47 volumiostreamer volumio[1051]: ---------------------------- MPD announces system playlist update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: Ignoring MPD Status Update Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 11ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: sendMpdCommand play took 9 milliseconds Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 8ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 7ms Oct 13 21:56:47 volumiostreamer volumio[1051]: info: ------------------------------ 5ms Oct 13 21:56:48 volumiostreamer volumio[1051]: info: Oct 13 21:56:48 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:48 volumiostreamer volumio[1051]: info: Oct 13 21:56:48 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:48 volumiostreamer volumio[1051]: info: Oct 13 21:56:48 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:48 volumiostreamer volumio[1051]: info: Oct 13 21:56:48 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:48 volumiostreamer volumio[1051]: info: Oct 13 21:56:48 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand status took 14 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand status took 15 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:48 volumiostreamer volumio[1051]: info: Oct 13 21:56:48 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:48 volumiostreamer volumio[1051]: info: Oct 13 21:56:48 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:48 volumiostreamer volumio[1051]: info: Oct 13 21:56:48 volumiostreamer volumio[1051]: ---------------------------- MPD announces state update: player Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::getState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand status Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand status took 37 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand status took 37 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand clearerror took 28 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand status took 28 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand clearerror took 27 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand status took 17 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand status took 14 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand status took 13 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseState Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AC/DC - Highway to Hell (Live At River Plate, December 2009)","artist":"acdcVEVO","album":"YouTube","uri":"https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube","trackType":"YouTube"} Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: CURRENT POSITION 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState stateService stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState currentStatus stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: No code Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AC/DC - Highway to Hell (Live At River Plate, December 2009)","artist":"acdcVEVO","album":"YouTube","uri":"https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube","trackType":"YouTube"} Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: CURRENT POSITION 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState stateService stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState currentStatus stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: No code Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ------------------------------ 109ms Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ------------------------------ 109ms Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand clearerror took 91 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand clearerror took 89 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 83 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 82 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 81 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 80 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 80 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: info: sendMpdCommand playlistinfo took 79 milliseconds Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: ControllerMpd::parseTrackInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AC/DC - Highway to Hell (Live At River Plate, December 2009)","artist":"acdcVEVO","album":"YouTube","uri":"https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube","trackType":"YouTube"} Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: CURRENT POSITION 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState stateService stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState currentStatus stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: No code Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AC/DC - Highway to Hell (Live At River Plate, December 2009)","artist":"acdcVEVO","album":"YouTube","uri":"https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube","trackType":"YouTube"} Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: CURRENT POSITION 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState stateService stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState currentStatus stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: No code Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AC/DC - Highway to Hell (Live At River Plate, December 2009)","artist":"acdcVEVO","album":"YouTube","uri":"https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube","trackType":"YouTube"} Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: CURRENT POSITION 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState stateService stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState currentStatus stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: No code Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AC/DC - Highway to Hell (Live At River Plate, December 2009)","artist":"acdcVEVO","album":"YouTube","uri":"https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube","trackType":"YouTube"} Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: CURRENT POSITION 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState stateService stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState currentStatus stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: No code Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AC/DC - Highway to Hell (Live At River Plate, December 2009)","artist":"acdcVEVO","album":"YouTube","uri":"https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube","trackType":"YouTube"} Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: CURRENT POSITION 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState stateService stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState currentStatus stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: No code Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ControllerMpd::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::servicePushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CorePlayQueue::getTrack 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AC/DC - Highway to Hell (Live At River Plate, December 2009)","artist":"acdcVEVO","album":"YouTube","uri":"https://rr7---sn-8vq54voxn25po-cjol.googlevideo.com/videoplayback?expire=1791943001&ei=-YzOareMDK7Qp-oP_LSV-Qs&ip=212.166.222.76&id=o-AE5bA8nn5HH_IjWngdCxpzUKBGQObcH02ob1u3OJ4fx9&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=875&met=1791921401%2C&mh=np&mm=18%2C29&mn=sn-8vq54voxn25po-cjol%2Csn-h5q7kne6&ms=aub%2Crdu&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=es&initcwndbps=818125&bui=AWzQHwpFfBpoZ2dYxnma0Wlhqgm-D9Nk8tbJ0vlGHlwQIcWIQS3fwVhTnTu3Y82Kj1cAJs5yzkfiEhAK&spc=I-rgIWwd_xJZ57CHkIci-WRKpLC6MrjTdup9PFhs4twY&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4418535&dur=284.401&lmt=1775298977340662&mt=1791920991&fvip=2&keepalive=yes&fexp=51565116%2C52112905%2C52184232&c=ANDROID_VR&txp=5532534&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRgIhAODWoORH3ONPNRLs1PTRgL0Nja5yT_Lvr7n0WBTooRGpAiEAp2lpYdXS-15c8Jbdg7rWEBxXiusalU8TvEohyix8CWU%3D&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgbmXp6rihgWGR49qIYnU3-RpTRXaonFKPycB88cQtHAYCIB5qi5zuSmFOCfPTw4d1dQJSgoLJ8OLOQqASYB3uk6V9&pot=MlviyDrZXOKVEuKMVC64O40fYRB3Ep6ROG7QGMqoMnw8YzSr57JRb22FN60ej1L2wkX9WYwGCTlCcbaEuwHSUm2RiKAZ9IyVmiQ-a3-F7i7bUhBP3vFcBtCSa4ba&t.YouTube","trackType":"YouTube"} Oct 13 21:56:48 volumiostreamer volumio[1051]: verbose: CURRENT POSITION 0 Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState stateService stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::syncState currentStatus stop Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: No code Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreStateMachine::pushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: CoreCommandRouter::volumioPushState Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ------------------------------ 290ms Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ------------------------------ 289ms Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ------------------------------ 289ms Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ------------------------------ 269ms Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ------------------------------ 267ms Oct 13 21:56:48 volumiostreamer volumio[1051]: info: ------------------------------ 267ms Oct 13 21:56:56 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri Oct 13 21:56:56 volumiostreamer volumio[1051]: info: [ytmusic-browse] browseUri: ytmusic Oct 13 21:56:56 volumiostreamer volumio[1051]: info: Preload queue cleared Oct 13 21:56:56 volumiostreamer systemd[1]: systemd-timedated.service: Deactivated successfully. Oct 13 21:57:02 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 21:57:02 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 21:57:07 volumiostreamer volumio[1051]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 21:57:07 volumiostreamer volumio[1051]: error: [ytmusic] Error getting i18n options: VM operation timed out Error: VM operation timed out Oct 13 21:57:07 volumiostreamer volumio[1051]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Oct 13 21:57:07 volumiostreamer volumio[1051]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 21:57:07 volumiostreamer volumio[1051]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Oct 13 21:57:07 volumiostreamer volumio[1051]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Oct 13 21:57:07 volumiostreamer volumio[1051]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Oct 13 21:57:07 volumiostreamer volumio[1051]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 13 21:57:07 volumiostreamer volumio[1051]: warn: [ytmusic] Failed to get account config: VM operation timed out Error: VM operation timed out Oct 13 21:57:07 volumiostreamer volumio[1051]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Oct 13 21:57:07 volumiostreamer volumio[1051]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 21:57:07 volumiostreamer volumio[1051]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Oct 13 21:57:07 volumiostreamer volumio[1051]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Oct 13 21:57:07 volumiostreamer volumio[1051]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Oct 13 21:57:07 volumiostreamer volumio[1051]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 13 21:57:13 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service ytmusic showDisclaimer undefined Oct 13 21:57:13 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: ytmusic , showDisclaimer Oct 13 21:57:14 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service ytmusic acceptDisclaimer Oct 13 21:57:14 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: ytmusic , acceptDisclaimer Oct 13 21:57:14 volumiostreamer volumio[1051]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 21:57:14 volumiostreamer volumio[1051]: error: [ytmusic] Error getting i18n options: VM operation timed out Error: VM operation timed out Oct 13 21:57:14 volumiostreamer volumio[1051]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Oct 13 21:57:14 volumiostreamer volumio[1051]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 21:57:14 volumiostreamer volumio[1051]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Oct 13 21:57:14 volumiostreamer volumio[1051]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Oct 13 21:57:14 volumiostreamer volumio[1051]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Oct 13 21:57:14 volumiostreamer volumio[1051]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 13 21:57:14 volumiostreamer volumio[1051]: warn: [ytmusic] Failed to get account config: VM operation timed out Error: VM operation timed out Oct 13 21:57:14 volumiostreamer volumio[1051]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Oct 13 21:57:14 volumiostreamer volumio[1051]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 21:57:14 volumiostreamer volumio[1051]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Oct 13 21:57:14 volumiostreamer volumio[1051]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Oct 13 21:57:14 volumiostreamer volumio[1051]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Oct 13 21:57:14 volumiostreamer volumio[1051]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 13 21:57:21 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service ytmusic configSaveDisclaimer [object Object] Oct 13 21:57:21 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: ytmusic , configSaveDisclaimer Oct 13 21:57:21 volumiostreamer volumio[1051]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 21:57:21 volumiostreamer volumio[1051]: error: [ytmusic] Error getting i18n options: VM operation timed out Error: VM operation timed out Oct 13 21:57:21 volumiostreamer volumio[1051]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Oct 13 21:57:21 volumiostreamer volumio[1051]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 21:57:21 volumiostreamer volumio[1051]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Oct 13 21:57:21 volumiostreamer volumio[1051]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Oct 13 21:57:21 volumiostreamer volumio[1051]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Oct 13 21:57:21 volumiostreamer volumio[1051]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 13 21:57:21 volumiostreamer volumio[1051]: warn: [ytmusic] Failed to get account config: VM operation timed out Error: VM operation timed out Oct 13 21:57:21 volumiostreamer volumio[1051]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Oct 13 21:57:21 volumiostreamer volumio[1051]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 21:57:21 volumiostreamer volumio[1051]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Oct 13 21:57:21 volumiostreamer volumio[1051]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Oct 13 21:57:21 volumiostreamer volumio[1051]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Oct 13 21:57:21 volumiostreamer volumio[1051]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 13 21:57:41 volumiostreamer volumio[1051]: info: CALLMETHOD: music_service ytmusic configSaveI18n [object Object] Oct 13 21:57:41 volumiostreamer volumio[1051]: info: CoreCommandRouter::executeOnPlugin: ytmusic , configSaveI18n Oct 13 21:57:41 volumiostreamer volumio[1051]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 21:57:41 volumiostreamer volumio[1051]: Error: VM operation timed out Oct 13 21:57:41 volumiostreamer volumio[1051]: at InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:145:15) Oct 13 21:57:41 volumiostreamer volumio[1051]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 13 21:57:41 volumiostreamer volumio[1051]: at async #generateSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:169:35) Oct 13 21:57:41 volumiostreamer volumio[1051]: at async #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:113:25) Oct 13 21:57:41 volumiostreamer volumio[1051]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:97:9) Oct 13 21:57:41 volumiostreamer volumio[1051]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 13 21:57:41 volumiostreamer volumio[1051]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 21:57:42 volumiostreamer sudo[3307]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 21:56' Oct 13 21:57:42 volumiostreamer sudo[3307]: 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="f224c96f24bffeaafa716653a140d091b9b76522" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon May 19 11:28:05 UTC 2025" VOLUMIO_VERSION="0.067" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="178d9db9b0f50342f3fdf788565b826d"