Jun 23 08:31:01 volumio volumio[1059]: info: CoreCommandRouter::volumioGetQueue
Jun 23 08:31:01 volumio volumio[1059]: info: CoreStateMachine::getQueue
Jun 23 08:31:01 volumio volumio[1059]: info: CorePlayQueue::getQueue
Jun 23 08:31:01 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
Jun 23 08:31:01 volumio dbus-daemon[721]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.23' (uid=0 pid=1716 comm="timedatectl show --property=NTPSynchronized --valu")
Jun 23 08:31:01 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 23 08:31:01 volumio dbus-daemon[721]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 23 08:31:01 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 23 08:31:01 volumio setdatetime-helper.sh[1715]: Time is not synchronized. Attempting to sync...
Jun 23 08:31:01 volumio sudo[1724]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Mon, 23 Jun 2025 06:31:02 GMT#015'
Jun 23 08:31:01 volumio sudo[1724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jun 23 08:31:02 volumio setdatetime-helper.sh[1725]: Mon Jun 23 08:31:02 CEST 2025
Jun 23 08:31:02 volumio sudo[1724]: pam_unix(sudo:session): session closed for user root
Jun 23 08:31:02 volumio setdatetime-helper.sh[1715]: Time synchronized successfully.
Jun 23 08:31:02 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Jun 23 08:31:02 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Jun 23 08:31:02 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 23 08:31:02 volumio volumio[1059]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jun 23 08:31:02 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jun 23 08:31:02 volumio volumio[1059]: info: Received Get System Version
Jun 23 08:31:02 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 23 08:31:02 volumio volumio[1059]: info: Received Get System Info
Jun 23 08:31:02 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 08:31:02 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 08:31:02 volumio volumio[1059]: info: Discovery: Getting this device information
Jun 23 08:31:02 volumio volumio[1059]: info: CoreCommandRouter::volumioGetState
Jun 23 08:31:02 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:02 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 08:31:04 volumio volumio[1059]: Searching plugin music_service/youtube2
Jun 23 08:31:04 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Jun 23 08:31:04 volumio volumio[1059]: info: [youtube2] InnertubeLoader: creating Innertube instance...
Jun 23 08:31:15 volumio volumio[1059]: info: [youtube2] InnertubeLoader: obtaining po_token by visitorData...
Jun 23 08:31:16 volumio volumio[1059]: Searching plugin music_service/youtube2
Jun 23 08:31:16 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Jun 23 08:31:16 volumio volumio[1059]: Searching plugin music_service/youtube2
Jun 23 08:31:16 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Jun 23 08:31:17 volumio volumio[1059]: info: [youtube2] InnertubeLoader: obtained po_token (expires in 43200 seconds)
Jun 23 08:31:17 volumio volumio[1059]: info: [youtube2] InnertubeLoader: re-create Innertube instance with po_token
Jun 23 08:31:17 volumio volumio[1059]: info: [youtube2] InnertubeLoader: creating Innertube instance with po_token...
Jun 23 08:31:23 volumio volumio[1059]: info: [youtube2] InnertubeLoader: going to refresh po_token in 43100 seconds
Jun 23 08:31:24 volumio volumio[1059]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... {
Jun 23 08:31:24 volumio volumio[1059]: command_run: { startIndex: 0, length: 25, onTap: { innertubeCommand: [Object] } },
Jun 23 08:31:24 volumio volumio[1059]: input_data: { content: 'Blue Cafe - Buena · 4:04', commandRuns: [ [Object] ] },
Jun 23 08:31:24 volumio volumio[1059]: parsed_runs: [ { text: 'Blue Cafe - Buena · 4:04', startIndex: 0 } ]
Jun 23 08:31:24 volumio volumio[1059]: }
Jun 23 08:31:24 volumio volumio[1059]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... {
Jun 23 08:31:24 volumio volumio[1059]: command_run: { startIndex: 0, length: 32, onTap: { innertubeCommand: [Object] } },
Jun 23 08:31:24 volumio volumio[1059]: input_data: {
Jun 23 08:31:24 volumio volumio[1059]: content: 'Blue Cafe - Swieta W Nas · 3:19',
Jun 23 08:31:24 volumio volumio[1059]: commandRuns: [ [Object] ]
Jun 23 08:31:24 volumio volumio[1059]: },
Jun 23 08:31:24 volumio volumio[1059]: parsed_runs: [ { text: 'Blue Cafe - Swieta W Nas · 3:19', startIndex: 0 } ]
Jun 23 08:31:24 volumio volumio[1059]: }
Jun 23 08:31:24 volumio volumio[1059]: info: All search sources collected, pushing search results
Jun 23 08:31:24 volumio volumio[1059]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... {
Jun 23 08:31:24 volumio volumio[1059]: command_run: { startIndex: 0, length: 51, onTap: { innertubeCommand: [Object] } },
Jun 23 08:31:24 volumio volumio[1059]: input_data: {
Jun 23 08:31:24 volumio volumio[1059]: content: 'Lil Pump - ESSKEETIT [Official Music Video] · 3:03',
Jun 23 08:31:24 volumio volumio[1059]: commandRuns: [ [Object] ]
Jun 23 08:31:24 volumio volumio[1059]: },
Jun 23 08:31:24 volumio volumio[1059]: parsed_runs: [
Jun 23 08:31:24 volumio volumio[1059]: {
Jun 23 08:31:24 volumio volumio[1059]: text: 'Lil Pump - ESSKEETIT [Official Music Video] · 3:03',
Jun 23 08:31:24 volumio volumio[1059]: startIndex: 0
Jun 23 08:31:24 volumio volumio[1059]: }
Jun 23 08:31:24 volumio volumio[1059]: ]
Jun 23 08:31:24 volumio volumio[1059]: }
Jun 23 08:31:24 volumio volumio[1059]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... {
Jun 23 08:31:24 volumio volumio[1059]: command_run: { startIndex: 0, length: 63, onTap: { innertubeCommand: [Object] } },
Jun 23 08:31:24 volumio volumio[1059]: input_data: {
Jun 23 08:31:24 volumio volumio[1059]: content: 'Migos - Bad and Boujee ft Lil Uzi Vert [Official Video] · 5:35',
Jun 23 08:31:24 volumio volumio[1059]: commandRuns: [ [Object] ]
Jun 23 08:31:24 volumio volumio[1059]: },
Jun 23 08:31:24 volumio volumio[1059]: parsed_runs: [
Jun 23 08:31:24 volumio volumio[1059]: {
Jun 23 08:31:24 volumio volumio[1059]: text: 'Migos - Bad and Boujee ft Lil Uzi Vert [Official Video] · 5:35',
Jun 23 08:31:24 volumio volumio[1059]: startIndex: 0
Jun 23 08:31:24 volumio volumio[1059]: }
Jun 23 08:31:24 volumio volumio[1059]: ]
Jun 23 08:31:24 volumio volumio[1059]: }
Jun 23 08:31:24 volumio volumio[1059]: info: All search sources collected, pushing search results
Jun 23 08:31:25 volumio volumio[1059]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... {
Jun 23 08:31:25 volumio volumio[1059]: command_run: { startIndex: 0, length: 66, onTap: { innertubeCommand: [Object] } },
Jun 23 08:31:25 volumio volumio[1059]: input_data: {
Jun 23 08:31:25 volumio volumio[1059]: content: 'Buena Vista Social Club - Chan Chan (Official Lyric Video) · 4:19',
Jun 23 08:31:25 volumio volumio[1059]: commandRuns: [ [Object] ]
Jun 23 08:31:25 volumio volumio[1059]: },
Jun 23 08:31:25 volumio volumio[1059]: parsed_runs: [
Jun 23 08:31:25 volumio volumio[1059]: {
Jun 23 08:31:25 volumio volumio[1059]: text: 'Buena Vista Social Club - Chan Chan (Official Lyric Video) · 4:19',
Jun 23 08:31:25 volumio volumio[1059]: startIndex: 0
Jun 23 08:31:25 volumio volumio[1059]: }
Jun 23 08:31:25 volumio volumio[1059]: ]
Jun 23 08:31:25 volumio volumio[1059]: }
Jun 23 08:31:25 volumio volumio[1059]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... {
Jun 23 08:31:25 volumio volumio[1059]: command_run: { startIndex: 0, length: 72, onTap: { innertubeCommand: [Object] } },
Jun 23 08:31:25 volumio volumio[1059]: input_data: {
Jun 23 08:31:25 volumio volumio[1059]: content: 'Buena Vista Social Club - De Camino a La Vereda (Official Audio) · 5:07',
Jun 23 08:31:25 volumio volumio[1059]: commandRuns: [ [Object] ]
Jun 23 08:31:25 volumio volumio[1059]: },
Jun 23 08:31:25 volumio volumio[1059]: parsed_runs: [
Jun 23 08:31:25 volumio volumio[1059]: {
Jun 23 08:31:25 volumio volumio[1059]: text: 'Buena Vista Social Club - De Camino a La Vereda (Official Audio) · 5:07',
Jun 23 08:31:25 volumio volumio[1059]: startIndex: 0
Jun 23 08:31:25 volumio volumio[1059]: }
Jun 23 08:31:25 volumio volumio[1059]: ]
Jun 23 08:31:25 volumio volumio[1059]: }
Jun 23 08:31:25 volumio volumio[1059]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... {
Jun 23 08:31:25 volumio volumio[1059]: command_run: { startIndex: 0, length: 60, onTap: { innertubeCommand: [Object] } },
Jun 23 08:31:25 volumio volumio[1059]: input_data: {
Jun 23 08:31:25 volumio volumio[1059]: content: 'Buena Vista Social Club - Chan Chan (Official Audio) · 4:21',
Jun 23 08:31:25 volumio volumio[1059]: commandRuns: [ [Object] ]
Jun 23 08:31:25 volumio volumio[1059]: },
Jun 23 08:31:25 volumio volumio[1059]: parsed_runs: [
Jun 23 08:31:25 volumio volumio[1059]: {
Jun 23 08:31:25 volumio volumio[1059]: text: 'Buena Vista Social Club - Chan Chan (Official Audio) · 4:21',
Jun 23 08:31:25 volumio volumio[1059]: startIndex: 0
Jun 23 08:31:25 volumio volumio[1059]: }
Jun 23 08:31:25 volumio volumio[1059]: ]
Jun 23 08:31:25 volumio volumio[1059]: }
Jun 23 08:31:25 volumio volumio[1059]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... {
Jun 23 08:31:25 volumio volumio[1059]: command_run: { startIndex: 0, length: 72, onTap: { innertubeCommand: [Object] } },
Jun 23 08:31:25 volumio volumio[1059]: input_data: {
Jun 23 08:31:25 volumio volumio[1059]: content: 'Buena Vista Social Club - De Camino a La Vereda (Official Audio) · 5:07',
Jun 23 08:31:25 volumio volumio[1059]: commandRuns: [ [Object] ]
Jun 23 08:31:25 volumio volumio[1059]: },
Jun 23 08:31:25 volumio volumio[1059]: parsed_runs: [
Jun 23 08:31:25 volumio volumio[1059]: {
Jun 23 08:31:25 volumio volumio[1059]: text: 'Buena Vista Social Club - De Camino a La Vereda (Official Audio) · 5:07',
Jun 23 08:31:25 volumio volumio[1059]: startIndex: 0
Jun 23 08:31:25 volumio volumio[1059]: }
Jun 23 08:31:25 volumio volumio[1059]: ]
Jun 23 08:31:25 volumio volumio[1059]: }
Jun 23 08:31:25 volumio volumio[1059]: info: All search sources collected, pushing search results
Jun 23 08:31:29 volumio volumio[1059]: info: Preload queue cleared
Jun 23 08:31:29 volumio volumio[1059]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 23 08:31:29 volumio volumio[1059]: info: CoreStateMachine::ClearQueue
Jun 23 08:31:29 volumio volumio[1059]: info: CoreStateMachine::stop
Jun 23 08:31:29 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 08:31:29 volumio volumio[1059]: info: CorePlayQueue::clearPlayQueue
Jun 23 08:31:29 volumio volumio[1059]: info: CorePlayQueue::saveQueue
Jun 23 08:31:29 volumio volumio[1059]: info: CoreCommandRouter::volumioPushQueue
Jun 23 08:31:29 volumio volumio[1059]: info: CoreStateMachine::addQueueItems
Jun 23 08:31:29 volumio volumio[1059]: info: CorePlayQueue::addQueueItems
Jun 23 08:31:29 volumio volumio[1059]: info: Preload queue cleared
Jun 23 08:31:29 volumio volumio[1059]: info: Adding Item to queue: youtube2/search@query=buena%20vista%20social%20club/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22fE4Sf7vXgbo%22%2C%22playlistId%22%3A%22PLetv3SCC-r3bPinnDE7jWxKPJc-mpEalB%22%2C%22params%22%3A%22OAI%253D%22%7D%7D%2C%22browse%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22VLPLetv3SCC-r3bPinnDE7jWxKPJc-mpEalB%22%7D%7D%7D
Jun 23 08:31:29 volumio volumio[1059]: info: Exploding uri youtube2/search@query=buena%20vista%20social%20club/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22fE4Sf7vXgbo%22%2C%22playlistId%22%3A%22PLetv3SCC-r3bPinnDE7jWxKPJc-mpEalB%22%2C%22params%22%3A%22OAI%253D%22%7D%7D%2C%22browse%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22VLPLetv3SCC-r3bPinnDE7jWxKPJc-mpEalB%22%7D%7D%7D in service youtube2
Jun 23 08:31:29 volumio volumio[1059]: info: [youtube2-browse] explodeUri: youtube2/search@query=buena%20vista%20social%20club/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22fE4Sf7vXgbo%22%2C%22playlistId%22%3A%22PLetv3SCC-r3bPinnDE7jWxKPJc-mpEalB%22%2C%22params%22%3A%22OAI%253D%22%7D%7D%2C%22browse%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22VLPLetv3SCC-r3bPinnDE7jWxKPJc-mpEalB%22%7D%7D%7D
Jun 23 08:31:30 volumio volumio[1059]: info: CoreCommandRouter::volumioPushQueue
Jun 23 08:31:30 volumio volumio[1059]: info: CorePlayQueue::saveQueue
Jun 23 08:31:30 volumio volumio[1059]: info: CoreStateMachine::updateTrackBlock
Jun 23 08:31:30 volumio volumio[1059]: info: CorePlayQueue::getTrackBlock
Jun 23 08:31:30 volumio volumio[1059]: info: CoreCommandRouter::volumioPlay
Jun 23 08:31:30 volumio volumio[1059]: info: CoreStateMachine::play index 0
Jun 23 08:31:30 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 08:31:30 volumio volumio[1059]: info: CoreStateMachine::stop
Jun 23 08:31:30 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 08:31:30 volumio volumio[1059]: info: CoreStateMachine::play index undefined
Jun 23 08:31:30 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 08:31:30 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:30 volumio volumio[1059]: info: CoreStateMachine::startPlaybackTimer
Jun 23 08:31:30 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:30 volumio volumio[1059]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22fE4Sf7vXgbo%22%2C%22playlistId%22%3A%22PLetv3SCC-r3bPinnDE7jWxKPJc-mpEalB%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Buena%20Vista%20Social%20Club%20-%20Chan%20Chan%20(Official%20Lyric%20Video)%22%2C%22artist%22%3A%22Buena%20Vista%20Social%20Club%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FfE4Sf7vXgbo%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLAg2-3rETv7k3haauJIFTn0SKT0uw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22fE4Sf7vXgbo%22%2C%22playlistId%22%3A%22PLetv3SCC-r3bPinnDE7jWxKPJc-mpEalB%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
Jun 23 08:31:30 volumio volumio[1059]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(fE4Sf7vXgbo): No valid URL to decipher - retry with 'WEB_EMBEDDED' client.
Jun 23 08:31:31 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:31 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand stop
Jun 23 08:31:31 volumio volumio[1059]: info: sendMpdCommand stop took 4 milliseconds
Jun 23 08:31:31 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand clear
Jun 23 08:31:31 volumio volumio[1059]: info: sendMpdCommand clear took 0 milliseconds
Jun 23 08:31:31 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand addid "https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube"
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info: sendMpdCommand addid "https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube" took 14 milliseconds
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 13ms
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 13ms
Jun 23 08:31:31 volumio volumio[1059]: verbose: MPD COMMAND [object Object]
Jun 23 08:31:31 volumio volumio[1059]: verbose: MPD COMMAND [object Object]
Jun 23 08:31:31 volumio volumio[1059]: verbose: MPD COMMAND [object Object]
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 30ms
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 30ms
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 18ms
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 18ms
Jun 23 08:31:31 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 23 08:31:31 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand play
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info:
Jun 23 08:31:31 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:31 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 19ms
Jun 23 08:31:31 volumio volumio[1059]: info: sendMpdCommand play took 4 milliseconds
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 3ms
Jun 23 08:31:31 volumio volumio[1059]: info: ------------------------------ 2ms
Jun 23 08:31:31 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
Jun 23 08:31:32 volumio mpd[1390]: ffmpeg/opus: Could not update timestamps for skipped samples.
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand status took 8 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand status took 7 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand status took 7 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:32 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:32 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus stop
Jun 23 08:31:32 volumio volumio[1059]: info: ------------------------------ 58ms
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:32 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:32 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:32 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:32 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:32 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:32 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:32 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:32 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:32 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:32 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:32 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:32 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:32 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:32 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:32 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: ------------------------------ 319ms
Jun 23 08:31:32 volumio volumio[1059]: info: ------------------------------ 319ms
Jun 23 08:31:32 volumio volumio[1059]: info: ------------------------------ 318ms
Jun 23 08:31:32 volumio volumio[1059]: info: ------------------------------ 315ms
Jun 23 08:31:32 volumio volumio[1059]: info: ------------------------------ 319ms
Jun 23 08:31:32 volumio volumio[1059]: info: Preload queue cleared
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::ClearQueue
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::stop
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::stPlaybackTimer
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::updateTrackBlock
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrackBlock
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::serviceStop
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::serviceStop
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::stop
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand stop
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::clearPlayQueue
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::saveQueue
Jun 23 08:31:32 volumio volumio[1059]: info: CoreCommandRouter::volumioPushQueue
Jun 23 08:31:32 volumio volumio[1059]: info: CoreStateMachine::addQueueItems
Jun 23 08:31:32 volumio volumio[1059]: info: CorePlayQueue::addQueueItems
Jun 23 08:31:32 volumio volumio[1059]: info: Preload queue cleared
Jun 23 08:31:32 volumio volumio[1059]: info: Adding Item to queue: youtube2/search@query=buena%20vista%20social%20club/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22o5cELP06Mik%22%2C%22playlistId%22%3A%22PLkLGtfv9wqNJ_ZDzWBMEWJkQX4NUlqhDP%22%2C%22params%22%3A%22OAI%253D%22%7D%7D%2C%22browse%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22VLPLkLGtfv9wqNJ_ZDzWBMEWJkQX4NUlqhDP%22%7D%7D%7D
Jun 23 08:31:32 volumio volumio[1059]: info: Exploding uri youtube2/search@query=buena%20vista%20social%20club/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22o5cELP06Mik%22%2C%22playlistId%22%3A%22PLkLGtfv9wqNJ_ZDzWBMEWJkQX4NUlqhDP%22%2C%22params%22%3A%22OAI%253D%22%7D%7D%2C%22browse%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22VLPLkLGtfv9wqNJ_ZDzWBMEWJkQX4NUlqhDP%22%7D%7D%7D in service youtube2
Jun 23 08:31:32 volumio volumio[1059]: info: [youtube2-browse] explodeUri: youtube2/search@query=buena%20vista%20social%20club/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22o5cELP06Mik%22%2C%22playlistId%22%3A%22PLkLGtfv9wqNJ_ZDzWBMEWJkQX4NUlqhDP%22%2C%22params%22%3A%22OAI%253D%22%7D%7D%2C%22browse%22%3A%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22VLPLkLGtfv9wqNJ_ZDzWBMEWJkQX4NUlqhDP%22%7D%7D%7D
Jun 23 08:31:32 volumio mpd[1390]: ffmpeg/matroska,webm: File ended prematurely
Jun 23 08:31:32 volumio mpd[1390]: player: played "https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube"
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand stop took 113 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:32 volumio volumio[1059]: info: sendMpdCommand status took 1 milliseconds
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:32 volumio volumio[1059]: info:
Jun 23 08:31:32 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:32 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:32 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:33 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jun 23 08:31:33 volumio volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jun 23 08:31:33 volumio volumio[1059]: info: sendMpdCommand status took 2 milliseconds
Jun 23 08:31:33 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:33 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:33 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:33 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:33 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:33 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:33 volumio volumio[1059]: 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":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:33 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::syncState stateService stop
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus stop
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: No code
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: ------------------------------ 76ms
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioGetState
Jun 23 08:31:33 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 55 milliseconds
Jun 23 08:31:33 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 55 milliseconds
Jun 23 08:31:33 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:33 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:33 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:33 volumio volumio[1059]: 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":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:33 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::syncState stateService stop
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus stop
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: No code
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:33 volumio volumio[1059]: 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":"Buena Vista Social Club - Chan Chan (Official Lyric Video)","artist":"Buena Vista Social Club","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681890&ei=wvRYaKLKO_rC6dsP1Kv0gQ8&ip=94.172.95.126&id=o-AOuTB9QxDg2SLvoPH0IpqnPpk5rN5AK5I2Mxh61jgrnj&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660290%2C&mh=Eq&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLMN2B_EbFWfFD9hdDMn4kNK5R-DyxJ1Oij8iTZXkXoAtjKltgYiljdN37a7e442K4r6J4OEHClC&spc=l3OVKRWXBRzuEQUKcYKciydOdYD-F8dI6b2DXBavI2az2tH2E_U3Dg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=d8lLxslibgEwsHbQuWg2mzAQ&rqh=1&gir=yes&clen=4431460&dur=258.301&lmt=1728935322252639&mt=1750659911&fvip=3&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=5gzra4MgP9_qbw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhAMf18qmDXnjZTNGEU-YlkH9-dg1M0vPIxSKMLOL5uf3cAiEAizwMxb0OFV-xiA_9LOSq3LBd0lcub1RU05YUebz1EJ4%3D&sig=AJfQdSswRgIhAIPaptsOPnnR48JyuVNB4YPEfpuVs-6a-FKcBMCmDpgYAiEAlkbm2RQmdQO7nx6D4ct5gbZRu1WzTV6bO2pSbI0ScSI%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:33 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::syncState stateService stop
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus stop
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: No code
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:33 volumio volumio[1059]: info: ------------------------------ 176ms
Jun 23 08:31:33 volumio volumio[1059]: info: ------------------------------ 175ms
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPushQueue
Jun 23 08:31:33 volumio volumio[1059]: info: CorePlayQueue::saveQueue
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::updateTrackBlock
Jun 23 08:31:33 volumio volumio[1059]: info: CorePlayQueue::getTrackBlock
Jun 23 08:31:33 volumio volumio[1059]: info: CoreCommandRouter::volumioPlay
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::play index 0
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::stop
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::play index undefined
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 08:31:33 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:33 volumio volumio[1059]: info: CoreStateMachine::startPlaybackTimer
Jun 23 08:31:33 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:33 volumio volumio[1059]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22o5cELP06Mik%22%2C%22playlistId%22%3A%22PLkLGtfv9wqNJ_ZDzWBMEWJkQX4NUlqhDP%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Buena%20Vista%20Social%20Club%20-%20Chan%20Chan%20(Official%20Audio)%22%2C%22artist%22%3A%22World%20Circuit%20Records%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Fo5cELP06Mik%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCa1uTVmRmAMzLgYngUcW_-wcWCrQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22o5cELP06Mik%22%2C%22playlistId%22%3A%22PLkLGtfv9wqNJ_ZDzWBMEWJkQX4NUlqhDP%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D
Jun 23 08:31:34 volumio volumio[1059]: warn: [youtube2] Error getting stream with default client in VideoModel.getInfo(o5cELP06Mik): No valid URL to decipher - retry with 'WEB_EMBEDDED' client.
Jun 23 08:31:34 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:34 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand stop
Jun 23 08:31:34 volumio volumio[1059]: info: sendMpdCommand stop took 4 milliseconds
Jun 23 08:31:34 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand clear
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: info: sendMpdCommand clear took 4 milliseconds
Jun 23 08:31:34 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand addid "https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681894&ei=xvRYaP-XIa-H6dsPi9aSOA&ip=94.172.95.126&id=o-AJDnZIixu3vzn5S-GcwAOtHKYMmfJUUIdxehvad7KI1E&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660294%2C&mh=7R&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLM34AuqTfOKUlg2UPRDKhUNfw_HG2xbCi4wRZ1XiSyyLgp2H5hYFf0h5GAxNPqbysconcsVy0IO&spc=l3OVKXIWApJBYwEX4t8bUFmeEs7bUtedaN_oqvcJ5HyMQ_T97v4bpw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VWNJps_9-3trKiJ99D666RcQ&rqh=1&gir=yes&clen=4479347&dur=260.941&lmt=1742417727621284&mt=1750659911&fvip=5&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KrHaoxrdJd9XRw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMcLQ6EEWBcv3Yr2CF9x1hh3j0DHs9JUk-YVcKD1HqNkAiBXJSizNWOoFdyQlRP_PIQJCWZnsbX5mM1Ny3xXv6vE-w%3D%3D&sig=AJfQdSswRQIhALGHs0m8onC0A-21kN8rwOLxzn7qE5PPkGi5ecgnDWNsAiAB3-a76-4OArXXJSlj6YZZDJVUm50MhbWHuF3ftrPltg%3D%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube"
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: error: updateQueue error: null
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 11ms
Jun 23 08:31:34 volumio volumio[1059]: info: sendMpdCommand addid "https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681894&ei=xvRYaP-XIa-H6dsPi9aSOA&ip=94.172.95.126&id=o-AJDnZIixu3vzn5S-GcwAOtHKYMmfJUUIdxehvad7KI1E&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660294%2C&mh=7R&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLM34AuqTfOKUlg2UPRDKhUNfw_HG2xbCi4wRZ1XiSyyLgp2H5hYFf0h5GAxNPqbysconcsVy0IO&spc=l3OVKXIWApJBYwEX4t8bUFmeEs7bUtedaN_oqvcJ5HyMQ_T97v4bpw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VWNJps_9-3trKiJ99D666RcQ&rqh=1&gir=yes&clen=4479347&dur=260.941&lmt=1742417727621284&mt=1750659911&fvip=5&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KrHaoxrdJd9XRw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMcLQ6EEWBcv3Yr2CF9x1hh3j0DHs9JUk-YVcKD1HqNkAiBXJSizNWOoFdyQlRP_PIQJCWZnsbX5mM1Ny3xXv6vE-w%3D%3D&sig=AJfQdSswRQIhALGHs0m8onC0A-21kN8rwOLxzn7qE5PPkGi5ecgnDWNsAiAB3-a76-4OArXXJSlj6YZZDJVUm50MhbWHuF3ftrPltg%3D%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube" took 8 milliseconds
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 6ms
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 5ms
Jun 23 08:31:34 volumio volumio[1059]: verbose: MPD COMMAND [object Object]
Jun 23 08:31:34 volumio volumio[1059]: verbose: MPD COMMAND [object Object]
Jun 23 08:31:34 volumio volumio[1059]: verbose: MPD COMMAND [object Object]
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 14ms
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 9ms
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 6ms
Jun 23 08:31:34 volumio volumio[1059]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 23 08:31:34 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand play
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: info:
Jun 23 08:31:34 volumio volumio[1059]: ---------------------------- MPD announces system playlist update
Jun 23 08:31:34 volumio volumio[1059]: info: Ignoring MPD Status Update
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 20ms
Jun 23 08:31:34 volumio volumio[1059]: info: sendMpdCommand play took 10 milliseconds
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 9ms
Jun 23 08:31:34 volumio volumio[1059]: info: ------------------------------ 3ms
Jun 23 08:31:35 volumio mpd[1390]: ffmpeg/opus: Could not update timestamps for skipped samples.
Jun 23 08:31:35 volumio volumio[1059]: info:
Jun 23 08:31:35 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:35 volumio volumio[1059]: info:
Jun 23 08:31:35 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:35 volumio volumio[1059]: info:
Jun 23 08:31:35 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:35 volumio volumio[1059]: info:
Jun 23 08:31:35 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand status took 12 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand status took 12 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:35 volumio volumio[1059]: info:
Jun 23 08:31:35 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:35 volumio volumio[1059]: info:
Jun 23 08:31:35 volumio volumio[1059]: ---------------------------- MPD announces state update: player
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::getState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand status took 28 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand status took 25 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 19 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand status took 8 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand status took 5 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseState
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:35 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:35 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Audio)","artist":"World Circuit Records","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681894&ei=xvRYaP-XIa-H6dsPi9aSOA&ip=94.172.95.126&id=o-AJDnZIixu3vzn5S-GcwAOtHKYMmfJUUIdxehvad7KI1E&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660294%2C&mh=7R&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLM34AuqTfOKUlg2UPRDKhUNfw_HG2xbCi4wRZ1XiSyyLgp2H5hYFf0h5GAxNPqbysconcsVy0IO&spc=l3OVKXIWApJBYwEX4t8bUFmeEs7bUtedaN_oqvcJ5HyMQ_T97v4bpw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VWNJps_9-3trKiJ99D666RcQ&rqh=1&gir=yes&clen=4479347&dur=260.941&lmt=1742417727621284&mt=1750659911&fvip=5&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KrHaoxrdJd9XRw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMcLQ6EEWBcv3Yr2CF9x1hh3j0DHs9JUk-YVcKD1HqNkAiBXJSizNWOoFdyQlRP_PIQJCWZnsbX5mM1Ny3xXv6vE-w%3D%3D&sig=AJfQdSswRQIhALGHs0m8onC0A-21kN8rwOLxzn7qE5PPkGi5ecgnDWNsAiAB3-a76-4OArXXJSlj6YZZDJVUm50MhbWHuF3ftrPltg%3D%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:35 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus stop
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:35 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:35 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Audio)","artist":"World Circuit Records","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681894&ei=xvRYaP-XIa-H6dsPi9aSOA&ip=94.172.95.126&id=o-AJDnZIixu3vzn5S-GcwAOtHKYMmfJUUIdxehvad7KI1E&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660294%2C&mh=7R&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLM34AuqTfOKUlg2UPRDKhUNfw_HG2xbCi4wRZ1XiSyyLgp2H5hYFf0h5GAxNPqbysconcsVy0IO&spc=l3OVKXIWApJBYwEX4t8bUFmeEs7bUtedaN_oqvcJ5HyMQ_T97v4bpw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VWNJps_9-3trKiJ99D666RcQ&rqh=1&gir=yes&clen=4479347&dur=260.941&lmt=1742417727621284&mt=1750659911&fvip=5&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KrHaoxrdJd9XRw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMcLQ6EEWBcv3Yr2CF9x1hh3j0DHs9JUk-YVcKD1HqNkAiBXJSizNWOoFdyQlRP_PIQJCWZnsbX5mM1Ny3xXv6vE-w%3D%3D&sig=AJfQdSswRQIhALGHs0m8onC0A-21kN8rwOLxzn7qE5PPkGi5ecgnDWNsAiAB3-a76-4OArXXJSlj6YZZDJVUm50MhbWHuF3ftrPltg%3D%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:35 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:35 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: ------------------------------ 80ms
Jun 23 08:31:35 volumio volumio[1059]: info: ------------------------------ 90ms
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 58 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 58 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 57 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: info: sendMpdCommand playlistinfo took 57 milliseconds
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:35 volumio volumio[1059]: verbose: ControllerMpd::parseTrackInfo
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:35 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:35 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":238,"duration":261,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Audio)","artist":"World Circuit Records","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681894&ei=xvRYaP-XIa-H6dsPi9aSOA&ip=94.172.95.126&id=o-AJDnZIixu3vzn5S-GcwAOtHKYMmfJUUIdxehvad7KI1E&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660294%2C&mh=7R&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLM34AuqTfOKUlg2UPRDKhUNfw_HG2xbCi4wRZ1XiSyyLgp2H5hYFf0h5GAxNPqbysconcsVy0IO&spc=l3OVKXIWApJBYwEX4t8bUFmeEs7bUtedaN_oqvcJ5HyMQ_T97v4bpw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VWNJps_9-3trKiJ99D666RcQ&rqh=1&gir=yes&clen=4479347&dur=260.941&lmt=1742417727621284&mt=1750659911&fvip=5&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KrHaoxrdJd9XRw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMcLQ6EEWBcv3Yr2CF9x1hh3j0DHs9JUk-YVcKD1HqNkAiBXJSizNWOoFdyQlRP_PIQJCWZnsbX5mM1Ny3xXv6vE-w%3D%3D&sig=AJfQdSswRQIhALGHs0m8onC0A-21kN8rwOLxzn7qE5PPkGi5ecgnDWNsAiAB3-a76-4OArXXJSlj6YZZDJVUm50MhbWHuF3ftrPltg%3D%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:35 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:35 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:35 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:35 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":238,"duration":261,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Audio)","artist":"World Circuit Records","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681894&ei=xvRYaP-XIa-H6dsPi9aSOA&ip=94.172.95.126&id=o-AJDnZIixu3vzn5S-GcwAOtHKYMmfJUUIdxehvad7KI1E&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660294%2C&mh=7R&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLM34AuqTfOKUlg2UPRDKhUNfw_HG2xbCi4wRZ1XiSyyLgp2H5hYFf0h5GAxNPqbysconcsVy0IO&spc=l3OVKXIWApJBYwEX4t8bUFmeEs7bUtedaN_oqvcJ5HyMQ_T97v4bpw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VWNJps_9-3trKiJ99D666RcQ&rqh=1&gir=yes&clen=4479347&dur=260.941&lmt=1742417727621284&mt=1750659911&fvip=5&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KrHaoxrdJd9XRw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMcLQ6EEWBcv3Yr2CF9x1hh3j0DHs9JUk-YVcKD1HqNkAiBXJSizNWOoFdyQlRP_PIQJCWZnsbX5mM1Ny3xXv6vE-w%3D%3D&sig=AJfQdSswRQIhALGHs0m8onC0A-21kN8rwOLxzn7qE5PPkGi5ecgnDWNsAiAB3-a76-4OArXXJSlj6YZZDJVUm50MhbWHuF3ftrPltg%3D%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:35 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:35 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:35 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:35 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":238,"duration":261,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Audio)","artist":"World Circuit Records","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681894&ei=xvRYaP-XIa-H6dsPi9aSOA&ip=94.172.95.126&id=o-AJDnZIixu3vzn5S-GcwAOtHKYMmfJUUIdxehvad7KI1E&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660294%2C&mh=7R&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLM34AuqTfOKUlg2UPRDKhUNfw_HG2xbCi4wRZ1XiSyyLgp2H5hYFf0h5GAxNPqbysconcsVy0IO&spc=l3OVKXIWApJBYwEX4t8bUFmeEs7bUtedaN_oqvcJ5HyMQ_T97v4bpw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VWNJps_9-3trKiJ99D666RcQ&rqh=1&gir=yes&clen=4479347&dur=260.941&lmt=1742417727621284&mt=1750659911&fvip=5&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KrHaoxrdJd9XRw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMcLQ6EEWBcv3Yr2CF9x1hh3j0DHs9JUk-YVcKD1HqNkAiBXJSizNWOoFdyQlRP_PIQJCWZnsbX5mM1Ny3xXv6vE-w%3D%3D&sig=AJfQdSswRQIhALGHs0m8onC0A-21kN8rwOLxzn7qE5PPkGi5ecgnDWNsAiAB3-a76-4OArXXJSlj6YZZDJVUm50MhbWHuF3ftrPltg%3D%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:35 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:35 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: ControllerMpd::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::servicePushState
Jun 23 08:31:35 volumio volumio[1059]: info: CorePlayQueue::getTrack 0
Jun 23 08:31:35 volumio volumio[1059]: verbose: STATE SERVICE {"status":"play","position":0,"seek":238,"duration":261,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Buena Vista Social Club - Chan Chan (Official Audio)","artist":"World Circuit Records","album":"YouTube","uri":"https://rr4---sn-f5f7lnld.googlevideo.com/videoplayback?expire=1750681894&ei=xvRYaP-XIa-H6dsPi9aSOA&ip=94.172.95.126&id=o-AJDnZIixu3vzn5S-GcwAOtHKYMmfJUUIdxehvad7KI1E&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1750660294%2C&mh=7R&mm=31%2C26&mn=sn-f5f7lnld%2Csn-i5h7lnll&ms=au%2Conr&mv=m&mvi=4&pl=18&rms=au%2Cau&pcm2=yes&initcwndbps=3563750&bui=AY1jyLM34AuqTfOKUlg2UPRDKhUNfw_HG2xbCi4wRZ1XiSyyLgp2H5hYFf0h5GAxNPqbysconcsVy0IO&spc=l3OVKXIWApJBYwEX4t8bUFmeEs7bUtedaN_oqvcJ5HyMQ_T97v4bpw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=VWNJps_9-3trKiJ99D666RcQ&rqh=1&gir=yes&clen=4479347&dur=260.941&lmt=1742417727621284&mt=1750659911&fvip=5&keepalive=yes&fexp=51466642%2C51466697&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532534&n=KrHaoxrdJd9XRw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cpcm2%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhAMcLQ6EEWBcv3Yr2CF9x1hh3j0DHs9JUk-YVcKD1HqNkAiBXJSizNWOoFdyQlRP_PIQJCWZnsbX5mM1Ny3xXv6vE-w%3D%3D&sig=AJfQdSswRQIhALGHs0m8onC0A-21kN8rwOLxzn7qE5PPkGi5ecgnDWNsAiAB3-a76-4OArXXJSlj6YZZDJVUm50MhbWHuF3ftrPltg%3D%3D&pot=MpgBbQXzzO9KlQZtOdw7JNVs5EYas8Mn7M5TMvcq3hhL1LW6skOarnRrNAhQRURwkJ6wnvhc9lMmUPbRvlf_39qTh9XlVVBbJmVmUv-08CcsSEQpfzGRtfS9MC1w03UCQzdPTxC-KM1cA1W8h4bxnqi7CyWVLOwZbeZvg7Tl145QujabDOxFD_iaX__wlRj9a9qlkq6H-NnmjVo%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jun 23 08:31:35 volumio volumio[1059]: verbose: CURRENT POSITION 0
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState stateService play
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::syncState currentStatus play
Jun 23 08:31:35 volumio volumio[1059]: info: Received an update from plugin. extracting info from payload
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreStateMachine::pushState
Jun 23 08:31:35 volumio volumio[1059]: info: CoreCommandRouter::volumioPushState
Jun 23 08:31:35 volumio volumio[1059]: info: ------------------------------ 217ms
Jun 23 08:31:35 volumio volumio[1059]: info: ------------------------------ 217ms
Jun 23 08:31:35 volumio volumio[1059]: info: ------------------------------ 195ms
Jun 23 08:31:35 volumio volumio[1059]: info: ------------------------------ 190ms
Jun 23 08:31:40 volumio volumio[1059]: info: CoreCommandRouter::volumioGetState
Jun 23 08:31:52 volumio volumio[1059]: info: CoreCommandRouter::volumioGetState
Jun 23 08:32:08 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
Jun 23 08:32:08 volumio dbus-daemon[721]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.25' (uid=0 pid=1894 comm="timedatectl show --property=NTPSynchronized --valu")
Jun 23 08:32:08 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 23 08:32:08 volumio dbus-daemon[721]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 23 08:32:08 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 23 08:32:08 volumio setdatetime-helper.sh[1891]: Time is not synchronized. Attempting to sync...
Jun 23 08:32:08 volumio sudo[1902]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Mon, 23 Jun 2025 06:32:08 GMT#015'
Jun 23 08:32:08 volumio sudo[1902]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jun 23 08:32:08 volumio setdatetime-helper.sh[1903]: Mon Jun 23 08:32:08 CEST 2025
Jun 23 08:32:08 volumio setdatetime-helper.sh[1891]: Time synchronized successfully.
Jun 23 08:32:08 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Jun 23 08:32:08 volumio sudo[1902]: pam_unix(sudo:session): session closed for user root
Jun 23 08:32:08 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Jun 23 08:32:08 volumio systemd-journald[336]: Time jumped backwards, rotating.
Jun 23 08:32:22 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jun 23 08:32:22 volumio volumio[1059]: info: Preload queue cleared
Jun 23 08:32:24 volumio volumio[1059]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jun 23 08:32:25 volumio volumio[1059]: Use XMLElement.setAttribute instead
Jun 23 08:32:25 volumio volumio[1059]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 23 08:32:25 volumio volumio[1059]: TypeError: children[i].attr(...).value is not a function
Jun 23 08:32:25 volumio volumio[1059]: at /volumio/app/plugins/music_service/webradio/index.js:428:46
Jun 23 08:32:25 volumio volumio[1059]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jun 23 08:32:25 volumio volumio[1059]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 23 08:32:26 volumio sudo[1982]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-23 08:31'
Jun 23 08:32:26 volumio sudo[1982]: 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="4a70cb031e64a8e498efc3e29470650871ff7d54"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025"
VOLUMIO_VERSION="4.005"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"