Oct 12 22:02:29 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:29 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:29 volumio volumio[1224]: info: Prefetching next song Oct 12 22:02:29 volumio volumio[1224]: error: [youtube2-play] Prefetch failed: Error: Cannot prefetch with yt-dlp as time taken will exceed Volumio's limit Oct 12 22:02:34 volumio volumio[1224]: info: Oct 12 22:02:34 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:34 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:34 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:34 volumio volumio[1224]: info: Oct 12 22:02:34 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:34 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:34 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:34 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:34 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:34 volumio volumio[1224]: info: Oct 12 22:02:34 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:34 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:34 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:34 volumio volumio[1224]: info: sendMpdCommand status took 3 milliseconds Oct 12 22:02:34 volumio volumio[1224]: info: sendMpdCommand status took 2 milliseconds Oct 12 22:02:34 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:34 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:34 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 22:02:34 volumio volumio[1224]: verbose: CURRENT POSITION 0 Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::syncState stateService stop Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::play index undefined Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:34 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::startPlaybackTimer Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%221SCOimBo5tg%22%2C%22playlistId%22%3A%22RD1SCOimBo5tg%22%2C%22params%22%3A%22wAEBqgMHQUxMSVNPTroDCgjgheWpwPaNpwK6AwoI1tOnp_L0poRaugMLCOHgmea35s2hjgG6AwoIlaPb9ciU2p1dugMKCMmws6y2mcLKDroDJBIiUExKZmVPR1c2UlMzOFJjTFpFZE5xdXNkTm9pa0hLMWZqLboDCgjgrOmSsdLu9Vy6AyQSIlBMa1VWTWtjVlFjd2hEc09uNEVjZzF0RExMTkVMZ2N5dEy6AwsIhpeVi_PPr7jDAboDJBIiUExRc3I2ckN3N1Brd1ZXRTBLeHI3TzdUcGItblBDV3p2NroDCgj4-f6x0dP7nRC6AwoIoIuN9MK7urdi8gMFDbg7HD-4BQE%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Alison%20Krauss%20-%20When%20You%20Say%20Nothing%20At%20All%22%2C%22artist%22%3A%22Alison%20Krauss%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F1SCOimBo5tg%2Fhq720.jpg%3Fsqp%3D-oaymwEgCNAFEJQDSFXyq4qpAxIIARUAAIhCGAFwAcABBrgC9xg%3D%26rs%3DAOn4CLAYnV1z68alasaG6zSwcCojCCImdQ%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%221SCOimBo5tg%22%2C%22playlistId%22%3A%22RD1SCOimBo5tg%22%2C%22params%22%3A%22wAEBqgMHQUxMSVNPTroDCgjgheWpwPaNpwK6AwoI1tOnp_L0poRaugMLCOHgmea35s2hjgG6AwoIlaPb9ciU2p1dugMKCMmws6y2mcLKDroDJBIiUExKZmVPR1c2UlMzOFJjTFpFZE5xdXNkTm9pa0hLMWZqLboDCgjgrOmSsdLu9Vy6AyQSIlBMa1VWTWtjVlFjd2hEc09uNEVjZzF0RExMTkVMZ2N5dEy6AwsIhpeVi_PPr7jDAboDJBIiUExRc3I2ckN3N1Brd1ZXRTBLeHI3TzdUcGItblBDV3p2NroDCgj4-f6x0dP7nRC6AwoIoIuN9MK7urdi8gMFDbg7HD-4BQE%253D%22%7D%7D%7D Oct 12 22:02:34 volumio volumio[1224]: verbose: [youtube2] [yt-dlp] Ready to fetch streaming URL for "https://www.youtube.com/watch?v=1SCOimBo5tg" with yt-dlp version 2026.08.19 Oct 12 22:02:34 volumio volumio[1224]: verbose: [youtube2] [yt-dlp] Going to execute: /data/plugins/music_service/youtube2/.yt-dlp/installed/2026.08.19/yt-dlp --cookies /data/plugins/music_service/youtube2/.yt-dlp/cookies/cookies_youtube_com.txt -q --js-runtime node --remote-components ejs:github -f bestaudio/best --get-url https://www.youtube.com/watch?v=1SCOimBo5tg Oct 12 22:02:34 volumio volumio[1224]: info: ------------------------------ 46ms Oct 12 22:02:34 volumio volumio[1224]: info: ------------------------------ 47ms Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:34 volumio volumio[1224]: info: sendMpdCommand status took 64 milliseconds Oct 12 22:02:34 volumio volumio[1224]: info: sendMpdCommand status took 66 milliseconds Oct 12 22:02:34 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:34 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:34 volumio volumio[1224]: info: [youtube2] (AutoplayManager) MPD 'stop' event received Oct 12 22:02:34 volumio volumio[1224]: info: [youtube2] (AutoplayManager) Check if autoplay needed Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: [youtube2] (AutoplayManager) Autoplay not applicable to state: {"random":null,"repeat":true,"repeatSingle":false} Oct 12 22:02:34 volumio volumio[1224]: info: [youtube2] (AutoplayManager) Removed mpdStateListener Oct 12 22:02:34 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:34 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:34 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:34 volumio volumio[1224]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd Oct 12 22:02:34 volumio volumio[1224]: info: ------------------------------ 80ms Oct 12 22:02:34 volumio volumio[1224]: info: [youtube2] Obtained PO token for video #1SCOimBo5tg: Ml1xoAXEJkAaxnHmMcCFwWKlZk24y9-sZVp4iPu_eQy4QYwJTfIAa_jPn6Ru9as9Bg0t0fIG7IGekrumshTczNwsMuMkiJa6h_DjeJfRqIgKH56i83u9jaa7ztFdeME= Oct 12 22:02:35 volumio volumio[1224]: info: [youtube2] Obtained PO token for video #1SCOimBo5tg: Ml3chX1tgs6-7tzDSWkhT8aNy2jAYnsiwXLVrYMW3YIcaSEsNVuk5VznMoEWXA-zoiWA9IqvSA86uhaDyr14QngEn8ZcITI0I9hOXe94DAauN_4PIQLZdOYTWb-KIZY= Oct 12 22:02:37 volumio volumio[1224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:02:37 volumio volumio[1224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 22:02:39 volumio volumio[1224]: verbose: [youtube2] [yt-dlp] https://www.youtube.com/watch?v=1SCOimBo5tg: https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D Oct 12 22:02:39 volumio volumio[1224]: info: [youtube2] (AutoplayManager) Enabled Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand stop took 0 milliseconds Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand clear took 0 milliseconds Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand addid "https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D&t.YouTube" Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: error: updateQueue error: null Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 3ms Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand addid "https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D&t.YouTube" took 2 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 2ms Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 1ms Oct 12 22:02:39 volumio volumio[1224]: verbose: MPD COMMAND [object Object] Oct 12 22:02:39 volumio volumio[1224]: verbose: MPD COMMAND [object Object] Oct 12 22:02:39 volumio volumio[1224]: verbose: MPD COMMAND [object Object] Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 4ms Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 2ms Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand play Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces system playlist update Oct 12 22:02:39 volumio volumio[1224]: info: Ignoring MPD Status Update Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 4ms Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 3ms Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand play took 3 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 3ms Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 2ms Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand status took 28 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand status took 28 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand status took 29 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand status took 2 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:39 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:39 volumio volumio[1224]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss - When You Say Nothing At All","artist":"AlisonKraussVEVO","album":"YouTube","uri":"https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D&t.YouTube","trackType":"YouTube"} Oct 12 22:02:39 volumio volumio[1224]: verbose: CURRENT POSITION 0 Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState stateService play Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState currentStatus stop Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:39 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:39 volumio volumio[1224]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss - When You Say Nothing At All","artist":"AlisonKraussVEVO","album":"YouTube","uri":"https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D&t.YouTube","trackType":"YouTube"} Oct 12 22:02:39 volumio volumio[1224]: verbose: CURRENT POSITION 0 Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState stateService play Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:02:39 volumio volumio[1224]: info: Received an update from plugin. extracting info from payload Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: [youtube2] (AutoplayManager) Added mpdStateListener Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 37ms Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 40ms Oct 12 22:02:39 volumio volumio[1224]: info: Oct 12 22:02:39 volumio volumio[1224]: ---------------------------- MPD announces state update: player Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::getState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand status took 11 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:39 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:39 volumio volumio[1224]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss - When You Say Nothing At All","artist":"AlisonKraussVEVO","album":"YouTube","uri":"https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D&t.YouTube","trackType":"YouTube"} Oct 12 22:02:39 volumio volumio[1224]: verbose: CURRENT POSITION 0 Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState stateService play Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:02:39 volumio volumio[1224]: info: Received an update from plugin. extracting info from payload Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:39 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:39 volumio volumio[1224]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss - When You Say Nothing At All","artist":"AlisonKraussVEVO","album":"YouTube","uri":"https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D&t.YouTube","trackType":"YouTube"} Oct 12 22:02:39 volumio volumio[1224]: verbose: CURRENT POSITION 0 Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState stateService play Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:02:39 volumio volumio[1224]: info: Received an update from plugin. extracting info from payload Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 60ms Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 32ms Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand status took 26 milliseconds Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand playlistinfo took 26 milliseconds Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseState Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:39 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:39 volumio volumio[1224]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss - When You Say Nothing At All","artist":"AlisonKraussVEVO","album":"YouTube","uri":"https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D&t.YouTube","trackType":"YouTube"} Oct 12 22:02:39 volumio volumio[1224]: verbose: CURRENT POSITION 0 Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState stateService play Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:02:39 volumio volumio[1224]: info: Received an update from plugin. extracting info from payload Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 52ms Oct 12 22:02:39 volumio volumio[1224]: info: sendMpdCommand playlistinfo took 17 milliseconds Oct 12 22:02:39 volumio volumio[1224]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:02:39 volumio volumio[1224]: info: ControllerMpd::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::servicePushState Oct 12 22:02:39 volumio volumio[1224]: info: CorePlayQueue::getTrack 0 Oct 12 22:02:39 volumio volumio[1224]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss - When You Say Nothing At All","artist":"AlisonKraussVEVO","album":"YouTube","uri":"https://rr7---sn-n3cgv5qc5oq-bh26e.googlevideo.com/videoplayback?expire=1791831758&ei=btrMapHSDYPj9fwP-J2csAE&ip=123.215.119.202&id=o-AER0TMh__unHUyxSfUpreNQguDQLO75M6QNAbF3ZAhCg&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=313&met=1791810158%2C&mh=vE&mm=18%2C26&mn=sn-n3cgv5qc5oq-bh26e%2Csn-a5msenes&ms=aub%2Conr&mv=m&mvi=7&pl=23&rms=aub%2Caub&gcr=kr&initcwndbps=4069250&bui=AWzQHwrFLASrz-YsEOm0l6Yp8DqUWSVBBM4NTf4W-UrksPfZGpiRZYbWxsg99fdInif6haJ2vQnZAiUV&spc=I-rgIZkwTn6t5Q3XHWSSuA_SAf82rVyyhkVmfgrxzX8_4zV4vFqZBc-y058s&vprv=1&svpuc=1&mime=audio%2Fwebm&rqh=1&gir=yes&clen=4344750&dur=234.881&lmt=1789817345497184&mt=1791809831&fvip=1&epbp=1&keepalive=yes&fexp=51565116%2C52112905%2C52184231%2C52250513&c=VISIONOS&txp=5532234&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AE0s2JYwRAIgGRMvJYpI9y4ts2086a1rrbLm48pio6eEVJBTY39dvaECIFRmbJnV3DrJmBHWDUG75uvg8gI2krNU-9BmRqKkSlxB&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRgIhANDqS5UJ0FZwVcnv4atumiUu73ZFJd3mDWExINpiKyhXAiEAySEPwAZLjoA9vn1ZkHMbIiv3tVFdpivHr_UT06Yp5FI%3D&t.YouTube","trackType":"YouTube"} Oct 12 22:02:39 volumio volumio[1224]: verbose: CURRENT POSITION 0 Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState stateService play Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:02:39 volumio volumio[1224]: info: Received an update from plugin. extracting info from payload Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreStateMachine::pushState Oct 12 22:02:39 volumio volumio[1224]: info: CoreCommandRouter::volumioPushState Oct 12 22:02:39 volumio volumio[1224]: info: ------------------------------ 57ms Oct 12 22:02:41 volumio volumio[1224]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 22:02:41 volumio volumio[1224]: error: [ytmusic] Error getting i18n options: fetch failed TypeError: fetch failed Oct 12 22:02:41 volumio volumio[1224]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Oct 12 22:02:41 volumio volumio[1224]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 12 22:02:41 volumio volumio[1224]: at async Player.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:34366:19) Oct 12 22:02:41 volumio volumio[1224]: at async Session.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:34612:129) Oct 12 22:02:41 volumio volumio[1224]: at async Innertube.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:40158:27) Oct 12 22:02:41 volumio volumio[1224]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:65:45) Oct 12 22:02:41 volumio volumio[1224]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 12 22:02:41 volumio volumio[1224]: at async AccountModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:25) Oct 12 22:02:41 volumio volumio[1224]: at async AccountModel.getInfo (/data/plugins/music_service/ytmusic/dist/lib/model/AccountModel.js:7:31) Oct 12 22:02:41 volumio volumio[1224]: at async GenericViewHandler.browse (/data/plugins/music_service/ytmusic/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:25:25) Oct 12 22:02:41 volumio volumio[1224]: at async BrowseController.browseUri (/data/plugins/music_service/ytmusic/dist/lib/controller/browse/BrowseController.js:30:20) Oct 12 22:02:41 volumio volumio[1224]: warn: [ytmusic] Failed to get account config: fetch failed TypeError: fetch failed Oct 12 22:02:41 volumio volumio[1224]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Oct 12 22:02:41 volumio volumio[1224]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 12 22:02:41 volumio volumio[1224]: at async Player.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:34366:19) Oct 12 22:02:41 volumio volumio[1224]: at async Session.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:34612:129) Oct 12 22:02:41 volumio volumio[1224]: at async Innertube.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:40158:27) Oct 12 22:02:41 volumio volumio[1224]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:65:45) Oct 12 22:02:41 volumio volumio[1224]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 12 22:02:41 volumio volumio[1224]: at async AccountModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:25) Oct 12 22:02:41 volumio volumio[1224]: at async AccountModel.getInfo (/data/plugins/music_service/ytmusic/dist/lib/model/AccountModel.js:7:31) Oct 12 22:02:41 volumio volumio[1224]: at async GenericViewHandler.browse (/data/plugins/music_service/ytmusic/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:25:25) Oct 12 22:02:41 volumio volumio[1224]: at async BrowseController.browseUri (/data/plugins/music_service/ytmusic/dist/lib/controller/browse/BrowseController.js:30:20) Oct 12 22:03:57 volumio volumio[1224]: info: CALLMETHOD: music_service ytmusic configSaveAccount [object Object] Oct 12 22:03:57 volumio volumio[1224]: info: CoreCommandRouter::executeOnPlugin: ytmusic , configSaveAccount Oct 12 22:03:57 volumio volumio[1224]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 22:03:57 volumio volumio[1224]: TypeError: fetch failed Oct 12 22:03:57 volumio volumio[1224]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Oct 12 22:03:57 volumio volumio[1224]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 12 22:03:57 volumio volumio[1224]: at async Player.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:34366:19) Oct 12 22:03:57 volumio volumio[1224]: at async Session.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:34612:129) Oct 12 22:03:57 volumio volumio[1224]: at async Innertube.create (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:40158:27) Oct 12 22:03:57 volumio volumio[1224]: at async #init (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:65:45) Oct 12 22:03:57 volumio volumio[1224]: at async InnertubeWrapper.create (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:57:9) Oct 12 22:03:57 volumio volumio[1224]: at async AccountModel.getInnertube (/data/plugins/music_service/ytmusic/dist/lib/model/BaseModel.js:13:25) Oct 12 22:03:57 volumio volumio[1224]: at async AccountModel.getInfo (/data/plugins/music_service/ytmusic/dist/lib/model/AccountModel.js:7:31) Oct 12 22:03:57 volumio volumio[1224]: at async GenericViewHandler.browse (/data/plugins/music_service/ytmusic/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:25:25) Oct 12 22:03:57 volumio volumio[1224]: at async BrowseController.browseUri (/data/plugins/music_service/ytmusic/dist/lib/controller/browse/BrowseController.js:30:20) { Oct 12 22:03:57 volumio volumio[1224]: cause: ConnectTimeoutError: Connect Timeout Error Oct 12 22:03:57 volumio volumio[1224]: at onConnectTimeout (node:internal/deps/undici/undici:8522:28) Oct 12 22:03:57 volumio volumio[1224]: at node:internal/deps/undici/undici:8480:50 Oct 12 22:03:57 volumio volumio[1224]: at Immediate._onImmediate (node:internal/deps/undici/undici:8511:13) Oct 12 22:03:57 volumio volumio[1224]: at process.processImmediate (node:internal/timers:478:21) { Oct 12 22:03:57 volumio volumio[1224]: code: 'UND_ERR_CONNECT_TIMEOUT' Oct 12 22:03:57 volumio volumio[1224]: } Oct 12 22:03:57 volumio volumio[1224]: } Oct 12 22:03:57 volumio volumio[1224]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 22:03:58 volumio sudo[3576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 22:02' Oct 12 22:03:58 volumio sudo[3576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"