-- Logs begin at Fri 2024-04-05 22:08:44 +07, end at Fri 2024-04-05 22:17:52 +07. -- Apr 05 22:16:17 volumio ntpd[963]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 05 22:16:45 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Apr 05 22:16:45 volumio volumio[975]: info: [youtube2-browse] browseUri: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FElibrary%22%2C%22params%22%3A%22KgN5b3U%253D%22%7D%7D Apr 05 22:16:45 volumio volumio[975]: error: You need to be signed in to access this content. You can do this in the plugin settings. Error: You need to be signed in to access this content. You can do this in the plugin settings. Apr 05 22:16:45 volumio volumio[975]: at GenericViewHandler.browse (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:38:19) Apr 05 22:16:45 volumio volumio[975]: at runMicrotasks () Apr 05 22:16:45 volumio volumio[975]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 05 22:16:45 volumio volumio[975]: at async BrowseController.browseUri (/data/plugins/music_service/youtube2/dist/lib/controller/browse/index.js:35:20) Apr 05 22:16:45 volumio volumio[975]: error: Failed to execute browseSource: Error: You need to be signed in to access this content. You can do this in the plugin settings. Apr 05 22:16:52 volumio volumio[975]: Searching plugin music_service/youtube2 Apr 05 22:16:52 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Apr 05 22:16:52 volumio volumio[975]: SearchHeader changed! Apr 05 22:16:52 volumio volumio[975]: The following keys where altered: chip_bar Apr 05 22:16:52 volumio volumio[975]: The class has changed to: Apr 05 22:16:52 volumio volumio[975]: class SearchHeader extends YTNode { Apr 05 22:16:52 volumio volumio[975]: static type = 'SearchHeader'; Apr 05 22:16:52 volumio volumio[975]: search_filter_button: YTNodes.Button | null; Apr 05 22:16:52 volumio volumio[975]: chip_bar?: YTNodes.ChipCloud | null; Apr 05 22:16:52 volumio volumio[975]: constructor(data: RawNode) { Apr 05 22:16:52 volumio volumio[975]: super(); Apr 05 22:16:52 volumio volumio[975]: this.search_filter_button = Parser.parseItem(data.searchFilterButton, [ YTNodes.Button ]); Apr 05 22:16:52 volumio volumio[975]: this.chip_bar = Reflect.has(data, 'chipBar') ? Parser.parseItem(data.chipBar, [ YTNodes.ChipCloud ]) : undefined; Apr 05 22:16:52 volumio volumio[975]: } Apr 05 22:16:52 volumio volumio[975]: } Apr 05 22:16:52 volumio volumio[975]: info: All search sources collected, pushing search results Apr 05 22:16:53 volumio volumio[975]: Searching plugin music_service/youtube2 Apr 05 22:16:53 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Apr 05 22:16:54 volumio ntpd[963]: Soliciting pool server 2001:b031:5c02:ff00::5 Apr 05 22:16:54 volumio volumio[975]: info: All search sources collected, pushing search results Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::ClearQueue Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::stop Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::stPlaybackTimer Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::updateTrackBlock Apr 05 22:17:01 volumio volumio[975]: info: CorePlayQueue::getTrackBlock Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::pushState Apr 05 22:17:01 volumio volumio[975]: info: CorePlayQueue::getTrack 0 Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::volumioPushState Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::serviceStop Apr 05 22:17:01 volumio volumio[975]: info: CorePlayQueue::getTrack 0 Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::serviceStop Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 05 22:17:01 volumio volumio[975]: info: ControllerMpd::stop Apr 05 22:17:01 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand stop Apr 05 22:17:01 volumio volumio[975]: info: CorePlayQueue::clearPlayQueue Apr 05 22:17:01 volumio volumio[975]: info: CorePlayQueue::saveQueue Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::volumioPushQueue Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::addQueueItems Apr 05 22:17:01 volumio volumio[975]: info: CorePlayQueue::addQueueItems Apr 05 22:17:01 volumio volumio[975]: info: Preload queue cleared Apr 05 22:17:01 volumio volumio[975]: info: Adding Item to queue: youtube2/search@query=M%E1%BB%99c%20anh/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UCuutSru42e2zl0znLxSkWTg%22%7D%7D Apr 05 22:17:01 volumio volumio[975]: info: Exploding uri youtube2/search@query=M%E1%BB%99c%20anh/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UCuutSru42e2zl0znLxSkWTg%22%7D%7D in service youtube2 Apr 05 22:17:01 volumio volumio[975]: info: [youtube2-browse] explodeUri: youtube2/search@query=M%E1%BB%99c%20anh/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UCuutSru42e2zl0znLxSkWTg%22%7D%7D Apr 05 22:17:01 volumio volumio[975]: info: Apr 05 22:17:01 volumio volumio[975]: ---------------------------- MPD announces state update: player Apr 05 22:17:01 volumio volumio[975]: info: sendMpdCommand stop took 6 milliseconds Apr 05 22:17:01 volumio volumio[975]: info: ControllerMpd::getState Apr 05 22:17:01 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand status Apr 05 22:17:01 volumio volumio[975]: info: sendMpdCommand status took 2 milliseconds Apr 05 22:17:01 volumio volumio[975]: verbose: ControllerMpd::parseState Apr 05 22:17:01 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 05 22:17:01 volumio volumio[975]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 05 22:17:01 volumio volumio[975]: verbose: ControllerMpd::parseTrackInfo Apr 05 22:17:01 volumio volumio[975]: info: ControllerMpd::pushState Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::servicePushState Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::pushState Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::volumioPushState Apr 05 22:17:01 volumio volumio[975]: info: CorePlayQueue::getTrack 0 Apr 05 22:17:01 volumio volumio[975]: 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":"Qua Ngõ Nhà Em - Mộc Anh | BÀI HÁT HOT NHẤT NĂM 2024","artist":"Giọng Ca Để Đời","album":"YouTube","uri":"https://rr10---sn-42u-i5olk.googlevideo.com/videoplayback?expire=1712351751&ei=pxUQZvyaGLS_vcAP1pO6kAU&ip=113.23.44.134&id=o-AA0zTmXg8Waqr1kQ3ODtPaT2k3QH5d57mGikfyk_KTtT&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=7A&mm=31%2C26&mn=sn-42u-i5olk%2Csn-30a7rned&ms=au%2Conr&mv=m&mvi=10&pl=24&initcwndbps=1256250&spc=UWF9f0UNtd8Z3fMUC_kZeP_j4GLvoB0FpunByYvd-VjxRCw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=IqpRB899CrgRzMwFurncZYEQ&gir=yes&clen=6740577&dur=360.081&lmt=1709887764793587&mt=1712329496&fvip=1&keepalive=yes&fexp=51141542&c=WEB&sefc=1&txp=5532434&n=zWGlYRMccaIHpg&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRAIgbSygeJeFo4Vi4tzI6G8KcBR7JkXozy2TiHai_OHeifUCICdRIEytmNO6ewyjwViNOxE9n2-H7oyooLD9NXWXObly&sig=AJfQdSswRQIgP5C9Ds6aed2jQU8H0pcmkA388CCYndOuv6QSK1QzhYoCIQDv3DGfAb5co82crtXS8mKhfQ-pg4Zi2KKPElgtf_kc3A%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 05 22:17:01 volumio volumio[975]: verbose: CURRENT POSITION 0 Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::syncState stateService stop Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::syncState currentStatus stop Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::pushState Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::volumioPushState Apr 05 22:17:01 volumio volumio[975]: info: No code Apr 05 22:17:01 volumio volumio[975]: info: CoreStateMachine::pushState Apr 05 22:17:01 volumio volumio[975]: info: CoreCommandRouter::volumioPushState Apr 05 22:17:01 volumio volumio[975]: info: ------------------------------ 14ms Apr 05 22:17:03 volumio volumio[975]: info: CoreCommandRouter::volumioPushQueue Apr 05 22:17:03 volumio volumio[975]: info: CorePlayQueue::saveQueue Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::updateTrackBlock Apr 05 22:17:03 volumio volumio[975]: info: CorePlayQueue::getTrackBlock Apr 05 22:17:03 volumio volumio[975]: info: CoreCommandRouter::volumioPlay Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::play index 0 Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::stop Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::play index undefined Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 05 22:17:03 volumio volumio[975]: info: CorePlayQueue::getTrack 0 Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::startPlaybackTimer Apr 05 22:17:03 volumio volumio[975]: info: CorePlayQueue::getTrack 0 Apr 05 22:17:03 volumio volumio[975]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22RzdPemjnVBU%22%2C%22playlistId%22%3A%22UULFuutSru42e2zl0znLxSkWTg%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22L%C3%92NG%20M%E1%BA%B8%20-%20M%E1%BB%99c%20Anh%20ft%20Th%C3%B9y%20Trang%20%7C%20L%C3%B2ng%20M%E1%BA%B9%20bao%20la%20nh%C6%B0%20bi%E1%BB%83n%20Th%C3%A1i%20B%C3%ACnh%20d%E1%BA%A1t%20d%C3%A0o...%20OFFICIAL%20MV%22%2C%22artist%22%3A%22M%E1%BB%99c%20Anh%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FRzdPemjnVBU%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLBoLw3TlqhDwS6vH0fpSsicj4b6Og%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22RzdPemjnVBU%22%2C%22playlistId%22%3A%22UULFuutSru42e2zl0znLxSkWTg%22%2C%22params%22%3A%22OAE%253D%22%2C%22index%22%3A0%7D%7D%7D Apr 05 22:17:03 volumio volumio[975]: info: CorePlayQueue::getTrack 0 Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand stop Apr 05 22:17:03 volumio volumio[975]: info: sendMpdCommand stop took 1 milliseconds Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand clear Apr 05 22:17:03 volumio volumio[975]: info: Apr 05 22:17:03 volumio volumio[975]: ---------------------------- MPD announces system playlist update Apr 05 22:17:03 volumio volumio[975]: info: Ignoring MPD Status Update Apr 05 22:17:03 volumio volumio[975]: info: sendMpdCommand clear took 1 milliseconds Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand addid "https://rr6---sn-42u-i5ol6.googlevideo.com/videoplayback?expire=1712351823&ei=7xUQZvqFENSyvcAPi5i_oAE&ip=113.23.44.134&id=o-AJbSsWZj32jJMkYXfyxqxxx_vvfZBgVtETxoubcLQXit&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Iv&mm=31%2C26&mn=sn-42u-i5ol6%2Csn-30a7rne6&ms=au%2Conr&mv=m&mvi=6&pl=24&initcwndbps=1261250&spc=UWF9f6MPf8k674IPKwvrSTrZJFtRI9gjFu0IG-39eTbcMSs&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=TJ4NN3p2I_PRaTZyXW2CeNkQ&gir=yes&clen=6974737&dur=375.841&lmt=1710905728531240&mt=1712329995&fvip=1&keepalive=yes&fexp=51141542&c=WEB&sefc=1&txp=6308224&n=Mq7yty106uDJNw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgCu99dpk6F7Oh6pk3zG0sgykKaSIFKarxPry7MO_VCm8CIQD_kset6bES5rCA_6n4ddkNk1MIBcrgbYGDVCjEbHcH2A%3D%3D&sig=AJfQdSswRQIhAIjZo4O8OGzMHXvGPir3yeJyklaib84OWjnNvsKfNoTpAiBgVdLPilXq7wug7BRZJDg8yZ9V0Az2FBwvJCuPX552NQ%3D%3D&cver=2.20230104.01.00&t.YouTube" Apr 05 22:17:03 volumio volumio[975]: error: updateQueue error: null Apr 05 22:17:03 volumio volumio[975]: info: Apr 05 22:17:03 volumio volumio[975]: ---------------------------- MPD announces system playlist update Apr 05 22:17:03 volumio volumio[975]: info: Ignoring MPD Status Update Apr 05 22:17:03 volumio volumio[975]: info: ------------------------------ 2ms Apr 05 22:17:03 volumio volumio[975]: info: sendMpdCommand addid "https://rr6---sn-42u-i5ol6.googlevideo.com/videoplayback?expire=1712351823&ei=7xUQZvqFENSyvcAPi5i_oAE&ip=113.23.44.134&id=o-AJbSsWZj32jJMkYXfyxqxxx_vvfZBgVtETxoubcLQXit&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Iv&mm=31%2C26&mn=sn-42u-i5ol6%2Csn-30a7rne6&ms=au%2Conr&mv=m&mvi=6&pl=24&initcwndbps=1261250&spc=UWF9f6MPf8k674IPKwvrSTrZJFtRI9gjFu0IG-39eTbcMSs&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=TJ4NN3p2I_PRaTZyXW2CeNkQ&gir=yes&clen=6974737&dur=375.841&lmt=1710905728531240&mt=1712329995&fvip=1&keepalive=yes&fexp=51141542&c=WEB&sefc=1&txp=6308224&n=Mq7yty106uDJNw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgCu99dpk6F7Oh6pk3zG0sgykKaSIFKarxPry7MO_VCm8CIQD_kset6bES5rCA_6n4ddkNk1MIBcrgbYGDVCjEbHcH2A%3D%3D&sig=AJfQdSswRQIhAIjZo4O8OGzMHXvGPir3yeJyklaib84OWjnNvsKfNoTpAiBgVdLPilXq7wug7BRZJDg8yZ9V0Az2FBwvJCuPX552NQ%3D%3D&cver=2.20230104.01.00&t.YouTube" took 1 milliseconds Apr 05 22:17:03 volumio volumio[975]: verbose: MPD COMMAND [object Object] Apr 05 22:17:03 volumio volumio[975]: verbose: MPD COMMAND [object Object] Apr 05 22:17:03 volumio volumio[975]: verbose: MPD COMMAND [object Object] Apr 05 22:17:03 volumio volumio[975]: info: Apr 05 22:17:03 volumio volumio[975]: ---------------------------- MPD announces system playlist update Apr 05 22:17:03 volumio volumio[975]: info: Ignoring MPD Status Update Apr 05 22:17:03 volumio volumio[975]: info: ------------------------------ 2ms Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand play Apr 05 22:17:03 volumio volumio[975]: info: ------------------------------ 1ms Apr 05 22:17:03 volumio volumio[975]: info: sendMpdCommand play took 1 milliseconds Apr 05 22:17:03 volumio volumio[975]: info: Apr 05 22:17:03 volumio volumio[975]: ---------------------------- MPD announces state update: player Apr 05 22:17:03 volumio volumio[975]: info: ControllerMpd::getState Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand status Apr 05 22:17:03 volumio volumio[975]: info: sendMpdCommand status took 1 milliseconds Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::parseState Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 05 22:17:03 volumio volumio[975]: info: Apr 05 22:17:03 volumio volumio[975]: ---------------------------- MPD announces state update: player Apr 05 22:17:03 volumio volumio[975]: info: ControllerMpd::getState Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand status Apr 05 22:17:03 volumio volumio[975]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::parseTrackInfo Apr 05 22:17:03 volumio volumio[975]: info: ControllerMpd::pushState Apr 05 22:17:03 volumio volumio[975]: info: CoreCommandRouter::servicePushState Apr 05 22:17:03 volumio volumio[975]: info: CorePlayQueue::getTrack 0 Apr 05 22:17:03 volumio volumio[975]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":376,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LÒNG MẸ - Mộc Anh ft Thùy Trang | Lòng Mẹ bao la như biển Thái Bình dạt dào... OFFICIAL MV","artist":"Mộc Anh","album":"YouTube","uri":"https://rr6---sn-42u-i5ol6.googlevideo.com/videoplayback?expire=1712351823&ei=7xUQZvqFENSyvcAPi5i_oAE&ip=113.23.44.134&id=o-AJbSsWZj32jJMkYXfyxqxxx_vvfZBgVtETxoubcLQXit&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Iv&mm=31%2C26&mn=sn-42u-i5ol6%2Csn-30a7rne6&ms=au%2Conr&mv=m&mvi=6&pl=24&initcwndbps=1261250&spc=UWF9f6MPf8k674IPKwvrSTrZJFtRI9gjFu0IG-39eTbcMSs&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=TJ4NN3p2I_PRaTZyXW2CeNkQ&gir=yes&clen=6974737&dur=375.841&lmt=1710905728531240&mt=1712329995&fvip=1&keepalive=yes&fexp=51141542&c=WEB&sefc=1&txp=6308224&n=Mq7yty106uDJNw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgCu99dpk6F7Oh6pk3zG0sgykKaSIFKarxPry7MO_VCm8CIQD_kset6bES5rCA_6n4ddkNk1MIBcrgbYGDVCjEbHcH2A%3D%3D&sig=AJfQdSswRQIhAIjZo4O8OGzMHXvGPir3yeJyklaib84OWjnNvsKfNoTpAiBgVdLPilXq7wug7BRZJDg8yZ9V0Az2FBwvJCuPX552NQ%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 05 22:17:03 volumio volumio[975]: verbose: CURRENT POSITION 0 Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::syncState stateService play Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::syncState currentStatus stop Apr 05 22:17:03 volumio volumio[975]: info: ------------------------------ 3ms Apr 05 22:17:03 volumio volumio[975]: info: sendMpdCommand status took 2 milliseconds Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::parseState Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 05 22:17:03 volumio volumio[975]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 05 22:17:03 volumio volumio[975]: verbose: ControllerMpd::parseTrackInfo Apr 05 22:17:03 volumio volumio[975]: info: ControllerMpd::pushState Apr 05 22:17:03 volumio volumio[975]: info: CoreCommandRouter::servicePushState Apr 05 22:17:03 volumio volumio[975]: info: CorePlayQueue::getTrack 0 Apr 05 22:17:03 volumio volumio[975]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":376,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LÒNG MẸ - Mộc Anh ft Thùy Trang | Lòng Mẹ bao la như biển Thái Bình dạt dào... OFFICIAL MV","artist":"Mộc Anh","album":"YouTube","uri":"https://rr6---sn-42u-i5ol6.googlevideo.com/videoplayback?expire=1712351823&ei=7xUQZvqFENSyvcAPi5i_oAE&ip=113.23.44.134&id=o-AJbSsWZj32jJMkYXfyxqxxx_vvfZBgVtETxoubcLQXit&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Iv&mm=31%2C26&mn=sn-42u-i5ol6%2Csn-30a7rne6&ms=au%2Conr&mv=m&mvi=6&pl=24&initcwndbps=1261250&spc=UWF9f6MPf8k674IPKwvrSTrZJFtRI9gjFu0IG-39eTbcMSs&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=TJ4NN3p2I_PRaTZyXW2CeNkQ&gir=yes&clen=6974737&dur=375.841&lmt=1710905728531240&mt=1712329995&fvip=1&keepalive=yes&fexp=51141542&c=WEB&sefc=1&txp=6308224&n=Mq7yty106uDJNw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=ALClDIEwRQIgCu99dpk6F7Oh6pk3zG0sgykKaSIFKarxPry7MO_VCm8CIQD_kset6bES5rCA_6n4ddkNk1MIBcrgbYGDVCjEbHcH2A%3D%3D&sig=AJfQdSswRQIhAIjZo4O8OGzMHXvGPir3yeJyklaib84OWjnNvsKfNoTpAiBgVdLPilXq7wug7BRZJDg8yZ9V0Az2FBwvJCuPX552NQ%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 05 22:17:03 volumio volumio[975]: verbose: CURRENT POSITION 0 Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::syncState stateService play Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::syncState currentStatus play Apr 05 22:17:03 volumio volumio[975]: info: Received an update from plugin. extracting info from payload Apr 05 22:17:03 volumio volumio[975]: info: CoreStateMachine::pushState Apr 05 22:17:03 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 05 22:17:03 volumio volumio[975]: info: CoreCommandRouter::volumioPushState Apr 05 22:17:04 volumio volumio[975]: info: CoreStateMachine::pushState Apr 05 22:17:04 volumio volumio[975]: info: CoreCommandRouter::volumioPushState Apr 05 22:17:04 volumio volumio[975]: info: ------------------------------ 9ms Apr 05 22:17:15 volumio volumio[975]: info: CoreCommandRouter::volumioRemoveQueueItem Apr 05 22:17:15 volumio volumio[975]: info: CoreStateMachine::removeQueueItem Apr 05 22:17:15 volumio volumio[975]: info: CorePlayQueue::removeQueueItem 6 Apr 05 22:17:15 volumio volumio[975]: info: CorePlayQueue::saveQueue Apr 05 22:17:15 volumio volumio[975]: info: CoreCommandRouter::volumioPushQueue Apr 05 22:17:22 volumio volumio[975]: info: CoreCommandRouter::volumioRemoveQueueItem Apr 05 22:17:22 volumio volumio[975]: info: CoreStateMachine::removeQueueItem Apr 05 22:17:22 volumio volumio[975]: info: CorePlayQueue::removeQueueItem 10 Apr 05 22:17:22 volumio volumio[975]: info: CorePlayQueue::saveQueue Apr 05 22:17:22 volumio volumio[975]: info: CoreCommandRouter::volumioPushQueue Apr 05 22:17:39 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 05 22:17:39 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 05 22:17:50 volumio volumio[975]: info: Enabling plugin fusiondsp Apr 05 22:17:50 volumio volumio[975]: info: Loading plugin "fusiondsp"... Apr 05 22:17:50 volumio volumio[975]: info: Preparing to generate the ALSA configuration file Apr 05 22:17:50 volumio volumio[975]: info: Asound.conf file unchanged, so no further update is needed Apr 05 22:17:50 volumio volumio[975]: info: Output device has changed, restarting MPD Apr 05 22:17:50 volumio sudo[2517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 05 22:17:50 volumio sudo[2517]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 05 22:17:50 volumio sudo[2517]: pam_unix(sudo:session): session closed for user root Apr 05 22:17:50 volumio volumio[975]: info: Output device has changed, restarting Shairport Sync Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 05 22:17:50 volumio sudo[2521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 05 22:17:50 volumio sudo[2521]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 05 22:17:50 volumio systemd[1]: Stopping Music Player Daemon... Apr 05 22:17:50 volumio volumio[975]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 05 22:17:50 volumio volumio[975]: info: PLUGIN START: fusiondsp Apr 05 22:17:50 volumio volumio[975]: info: Loading i18n strings for locale vi Apr 05 22:17:50 volumio systemd[1]: mpd.service: Succeeded. Apr 05 22:17:50 volumio systemd[1]: Stopped Music Player Daemon. Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: FusionDsp - mixtype--------------------- Hardware Apr 05 22:17:50 volumio volumio[975]: info: Preparing to generate the ALSA configuration file Apr 05 22:17:50 volumio volumio[975]: info: Done. Apr 05 22:17:50 volumio volumio[975]: info: MPD Permissions set Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 05 22:17:50 volumio systemd[1]: Starting Music Player Daemon... Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: Asound.conf file unchanged, so no further update is needed Apr 05 22:17:50 volumio volumio[975]: info: Output device has changed, restarting MPD Apr 05 22:17:50 volumio sudo[2534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 05 22:17:50 volumio volumio[975]: info: Output device has changed, restarting Shairport Sync Apr 05 22:17:50 volumio sudo[2534]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 05 22:17:50 volumio sudo[2534]: pam_unix(sudo:session): session closed for user root Apr 05 22:17:50 volumio sudo[2536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 05 22:17:50 volumio sudo[2536]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 05 22:17:50 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 05 22:17:50 volumio systemd[1]: mpd.service: Succeeded. Apr 05 22:17:50 volumio systemd[1]: Stopped Music Player Daemon. Apr 05 22:17:50 volumio systemd[1]: Starting Music Player Daemon... Apr 05 22:17:50 volumio volumio[975]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 05 22:17:50 volumio volumio[975]: info: MPD Permissions set Apr 05 22:17:50 volumio volumio[975]: info: Starting Shairport Sync Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio sudo[2545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 05 22:17:50 volumio sudo[2545]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 05 22:17:50 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 05 22:17:50 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 05 22:17:50 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:50 volumio volumio[975]: info: Starting Shairport Sync Apr 05 22:17:50 volumio sudo[2555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 05 22:17:50 volumio sudo[2555]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 05 22:17:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 05 22:17:50 volumio volumio[975]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 05 22:17:50 volumio sudo[2545]: pam_unix(sudo:session): session closed for user root Apr 05 22:17:50 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 05 22:17:50 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 05 22:17:50 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 05 22:17:50 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 05 22:17:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 05 22:17:50 volumio sudo[2555]: pam_unix(sudo:session): session closed for user root Apr 05 22:17:50 volumio volumio[975]: info: Shairport-Sync Started Apr 05 22:17:50 volumio volumio[975]: info: Shairport-Sync Started Apr 05 22:17:50 volumio mpd[2542]: Apr 05 22:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 05 22:17:50 volumio systemd[1]: Started Music Player Daemon. Apr 05 22:17:50 volumio sudo[2521]: pam_unix(sudo:session): session closed for user root Apr 05 22:17:50 volumio sudo[2536]: pam_unix(sudo:session): session closed for user root Apr 05 22:17:51 volumio volumio[975]: error: MPD error: The expression evaluated to a falsy value: Apr 05 22:17:51 volumio volumio[975]: assert.ok(self.idling) Apr 05 22:17:51 volumio volumio[975]: error: The expression evaluated to a falsy value: Apr 05 22:17:51 volumio volumio[975]: assert.ok(self.idling) Apr 05 22:17:51 volumio volumio[975]: error: updateQueue error: null Apr 05 22:17:52 volumio volumio[975]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Apr 05 22:17:52 volumio volumio[975]: info: camilladsp service started and running in background, instance 1 Apr 05 22:17:52 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 05 22:17:52 volumio volumio[975]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 05 22:17:52 volumio volumio[975]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 05 22:17:52 volumio volumio[975]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 05 22:17:52 volumio volumio[975]: info: FusionDsp loaded Apr 05 22:17:52 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 05 22:17:52 volumio sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 05 22:17:52 volumio sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 05 22:17:52 volumio volumio[975]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 05 22:17:52 volumio volumio[975]: info: Adding Signal Path Element [object Object] Apr 05 22:17:52 volumio volumio[975]: info: Adding fusiondspeq DSP Signal Path Element Apr 05 22:17:52 volumio volumio[975]: info: FusionDsp - ---- installed callbackRead Apr 05 22:17:52 volumio volumio[975]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 05 22:17:52 volumio volumio[975]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 05 22:17:52 volumio volumio[975]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Apr 05 22:17:52 volumio volumio[975]: at onErrorNT (internal/child_process.js:472:16) Apr 05 22:17:52 volumio volumio[975]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Apr 05 22:17:52 volumio volumio[975]: errno: -2, Apr 05 22:17:52 volumio volumio[975]: code: 'ENOENT', Apr 05 22:17:52 volumio volumio[975]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 05 22:17:52 volumio volumio[975]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 05 22:17:52 volumio volumio[975]: spawnargs: [ Apr 05 22:17:52 volumio volumio[975]: '-p', Apr 05 22:17:52 volumio volumio[975]: 9876, Apr 05 22:17:52 volumio volumio[975]: '-o', Apr 05 22:17:52 volumio volumio[975]: '/tmp/camilladsp.log', Apr 05 22:17:52 volumio volumio[975]: '-l', Apr 05 22:17:52 volumio volumio[975]: 'warn', Apr 05 22:17:52 volumio volumio[975]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 05 22:17:52 volumio volumio[975]: ] Apr 05 22:17:52 volumio volumio[975]: } Apr 05 22:17:52 volumio volumio[975]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 05 22:17:52 volumio systemd[1]: Started FusionDsp Daemon. Apr 05 22:17:52 volumio sudo[2572]: pam_unix(sudo:session): session closed for user root Apr 05 22:17:52 volumio sudo[2584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-05 22:16 Apr 05 22:17:52 volumio sudo[2584]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"