-- Logs begin at Tue 2024-11-26 13:48:27 +07, end at Tue 2024-11-26 14:20:38 +07. -- Nov 26 14:19:08 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 26 14:19:08 volumio volumio[985]: info: CURURI: playlists/Chế linh by Nov 26 14:19:08 volumio volumio[985]: info: Preload queue cleared Nov 26 14:19:08 volumio volumio[985]: info: Preloading song: ytmusic/generic@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QpVsgheVow%22%2C%22playlistId%22%3A%22OLAK5uy_lI9BsOJYjiDcQE6ooU6gGzdpHJ85joaOs%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D Nov 26 14:19:08 volumio volumio[985]: info: Exploding uri ytmusic/generic@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QpVsgheVow%22%2C%22playlistId%22%3A%22OLAK5uy_lI9BsOJYjiDcQE6ooU6gGzdpHJ85joaOs%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D in service ytmusic Nov 26 14:19:08 volumio volumio[985]: info: [ytmusic-browse] explodeUri: ytmusic/generic@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QpVsgheVow%22%2C%22playlistId%22%3A%22OLAK5uy_lI9BsOJYjiDcQE6ooU6gGzdpHJ85joaOs%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D Nov 26 14:19:12 volumio volumio[985]: info: Preload queue cleared Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::ClearQueue Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::stop Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::stPlaybackTimer Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::updateTrackBlock Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrackBlock Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:12 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:12 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::serviceStop Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::serviceStop Nov 26 14:19:12 volumio volumio[985]: info: ControllerMpd::stop Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::clearPlayQueue Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::saveQueue Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushQueue Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::addQueueItems Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::addQueueItems Nov 26 14:19:12 volumio volumio[985]: info: Preload queue cleared Nov 26 14:19:12 volumio volumio[985]: info: Adding Item to queue: ytmusic/generic@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QpVsgheVow%22%2C%22playlistId%22%3A%22OLAK5uy_lI9BsOJYjiDcQE6ooU6gGzdpHJ85joaOs%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D Nov 26 14:19:12 volumio volumio[985]: info: Using cached record of: ytmusic/generic@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QpVsgheVow%22%2C%22playlistId%22%3A%22OLAK5uy_lI9BsOJYjiDcQE6ooU6gGzdpHJ85joaOs%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushQueue Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::saveQueue Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::updateTrackBlock Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrackBlock Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::volumioPlay Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::play index 0 Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::stop Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::play index undefined Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:12 volumio volumio[985]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22M%C6%B0%E1%BB%9Di%20N%C4%83m%20T%C3%ACnh%20C%C5%A9%22%2C%22artist%22%3A%22Ch%E1%BA%BF%20Linh%22%2C%22album%22%3A%22Ch%E1%BA%BF%20Linh%20%C4%90%E1%BA%B7c%20Bi%E1%BB%87t%20(H%C3%A1t%20cho%20ng%C6%B0%E1%BB%9Di%20t%C3%ACnh%20ph%E1%BB%A5)%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FquSZhzt3FsJ-vn6W4FxQ6ByHt8sjisOtFokNHaPy4apH9rG3sIxSdWlxbtuMOU96MDN9GSJ656wfh2M%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QpVsgheVow%22%2C%22playlistId%22%3A%22OLAK5uy_lI9BsOJYjiDcQE6ooU6gGzdpHJ85joaOs%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%22E6C1074327C0EE56%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%223QpVsgheVow%22%2C%22playlistId%22%3A%22OLAK5uy_lI9BsOJYjiDcQE6ooU6gGzdpHJ85joaOs%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%22E6C1074327C0EE56%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D Nov 26 14:19:12 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:12 volumio volumio[985]: info: Nov 26 14:19:12 volumio volumio[985]: ---------------------------- MPD announces state update: player Nov 26 14:19:12 volumio volumio[985]: info: sendMpdCommand stop took 62 milliseconds Nov 26 14:19:12 volumio volumio[985]: info: ControllerMpd::getState Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Nov 26 14:19:12 volumio volumio[985]: info: Nov 26 14:19:12 volumio volumio[985]: ---------------------------- MPD announces state update: player Nov 26 14:19:12 volumio volumio[985]: info: ControllerMpd::getState Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Nov 26 14:19:12 volumio volumio[985]: info: sendMpdCommand status took 0 milliseconds Nov 26 14:19:12 volumio volumio[985]: info: sendMpdCommand status took 0 milliseconds Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::parseState Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::parseState Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 14:19:12 volumio volumio[985]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 26 14:19:12 volumio volumio[985]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Nov 26 14:19:12 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Nov 26 14:19:12 volumio volumio[985]: info: ControllerMpd::pushState Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::servicePushState Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:12 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:12 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:12 volumio volumio[985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd Nov 26 14:19:12 volumio volumio[985]: info: ControllerMpd::pushState Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::servicePushState Nov 26 14:19:12 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:12 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:12 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:12 volumio volumio[985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd Nov 26 14:19:12 volumio volumio[985]: info: ------------------------------ 22ms Nov 26 14:19:12 volumio volumio[985]: info: ------------------------------ 21ms Nov 26 14:19:12 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:12 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:13 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 14:19:13 volumio volumio[985]: info: sendMpdCommand stop took 0 milliseconds Nov 26 14:19:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 14:19:13 volumio volumio[985]: info: Nov 26 14:19:13 volumio volumio[985]: ---------------------------- MPD announces system playlist update Nov 26 14:19:13 volumio volumio[985]: info: Ignoring MPD Status Update Nov 26 14:19:13 volumio volumio[985]: info: sendMpdCommand clear took 1 milliseconds Nov 26 14:19:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand addid "https://rr5---sn-8qj-i2ier.googlevideo.com/videoplayback?expire=1732627133&ei=XXZFZ5HBNvyg88EP99fh4Q4&ip=113.179.65.134&id=o-AIwlhlk2ygW6PMEZhRKnFfE1ssTURfz6ndIpctUWz4UX&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1732605533%2C&mh=NN&mm=31%2C29&mn=sn-8qj-i2ier%2Csn-8qj-i5ols&ms=au%2Crdu&mv=m&mvi=5&pl=23&rms=au%2Cau&gcr=vn&initcwndbps=1236250&bui=AQn3pFRYtA7khLZcFgF3YwL98WbaEcesjjjVzNzqLtXXNlxzrXrdltFqj8WdHwh6DK2WowMADErWo7-2&spc=qtApAbQc2Okm0HOE9e0o15og_OxlZwg9bxcUMinHB2_C51Sz4g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7MjxIgsOFKHGb1ekKmhL6YMQ&rqh=1&gir=yes&clen=6725255&dur=401.781&lmt=1714357383204806&mt=1732604960&fvip=6&keepalive=yes&fexp=51326932%2C51335594&c=WEB_REMIX&sefc=1&txp=2318224&n=tNM3FL1NnfjRng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRQIgR-6rKTBSb9zjH5Hg5sVUNc0IcMNhr1_rnru8cWQvxosCIQCk8-nfUcqV0ZxN-664Xlax_ZRPnbtUqPZfozjb2j2r9A%3D%3D&sig=AJfQdSswRgIhAMoKRXl1SJPzgsjtN-T1Xjpi1A0XsSEEIZlla8sc0pcrAiEAkCF81Hg3yE95PIjUVa_Io4bCuGxGzAlntyaz-fmODdQ%3D&cver=1.20211213.00.00&t.YouTube" Nov 26 14:19:13 volumio volumio[985]: info: Nov 26 14:19:13 volumio volumio[985]: ---------------------------- MPD announces system playlist update Nov 26 14:19:13 volumio volumio[985]: info: Ignoring MPD Status Update Nov 26 14:19:13 volumio volumio[985]: error: updateQueue error: null Nov 26 14:19:13 volumio volumio[985]: info: Nov 26 14:19:13 volumio volumio[985]: ---------------------------- MPD announces system playlist update Nov 26 14:19:13 volumio volumio[985]: info: Ignoring MPD Status Update Nov 26 14:19:13 volumio volumio[985]: info: ------------------------------ 2ms Nov 26 14:19:13 volumio volumio[985]: info: sendMpdCommand addid "https://rr5---sn-8qj-i2ier.googlevideo.com/videoplayback?expire=1732627133&ei=XXZFZ5HBNvyg88EP99fh4Q4&ip=113.179.65.134&id=o-AIwlhlk2ygW6PMEZhRKnFfE1ssTURfz6ndIpctUWz4UX&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1732605533%2C&mh=NN&mm=31%2C29&mn=sn-8qj-i2ier%2Csn-8qj-i5ols&ms=au%2Crdu&mv=m&mvi=5&pl=23&rms=au%2Cau&gcr=vn&initcwndbps=1236250&bui=AQn3pFRYtA7khLZcFgF3YwL98WbaEcesjjjVzNzqLtXXNlxzrXrdltFqj8WdHwh6DK2WowMADErWo7-2&spc=qtApAbQc2Okm0HOE9e0o15og_OxlZwg9bxcUMinHB2_C51Sz4g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7MjxIgsOFKHGb1ekKmhL6YMQ&rqh=1&gir=yes&clen=6725255&dur=401.781&lmt=1714357383204806&mt=1732604960&fvip=6&keepalive=yes&fexp=51326932%2C51335594&c=WEB_REMIX&sefc=1&txp=2318224&n=tNM3FL1NnfjRng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRQIgR-6rKTBSb9zjH5Hg5sVUNc0IcMNhr1_rnru8cWQvxosCIQCk8-nfUcqV0ZxN-664Xlax_ZRPnbtUqPZfozjb2j2r9A%3D%3D&sig=AJfQdSswRgIhAMoKRXl1SJPzgsjtN-T1Xjpi1A0XsSEEIZlla8sc0pcrAiEAkCF81Hg3yE95PIjUVa_Io4bCuGxGzAlntyaz-fmODdQ%3D&cver=1.20211213.00.00&t.YouTube" took 1 milliseconds Nov 26 14:19:13 volumio volumio[985]: info: ------------------------------ 1ms Nov 26 14:19:13 volumio volumio[985]: verbose: MPD COMMAND [object Object] Nov 26 14:19:13 volumio volumio[985]: verbose: MPD COMMAND [object Object] Nov 26 14:19:13 volumio volumio[985]: verbose: MPD COMMAND [object Object] Nov 26 14:19:13 volumio volumio[985]: info: Nov 26 14:19:13 volumio volumio[985]: ---------------------------- MPD announces system playlist update Nov 26 14:19:13 volumio volumio[985]: info: Ignoring MPD Status Update Nov 26 14:19:13 volumio volumio[985]: info: Nov 26 14:19:13 volumio volumio[985]: ---------------------------- MPD announces system playlist update Nov 26 14:19:13 volumio volumio[985]: info: Ignoring MPD Status Update Nov 26 14:19:13 volumio volumio[985]: info: ------------------------------ 2ms Nov 26 14:19:13 volumio volumio[985]: info: ------------------------------ 1ms Nov 26 14:19:13 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 26 14:19:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand play Nov 26 14:19:13 volumio volumio[985]: info: Nov 26 14:19:13 volumio volumio[985]: ---------------------------- MPD announces system playlist update Nov 26 14:19:13 volumio volumio[985]: info: Ignoring MPD Status Update Nov 26 14:19:13 volumio volumio[985]: info: ------------------------------ 1ms Nov 26 14:19:13 volumio volumio[985]: info: sendMpdCommand play took 1 milliseconds Nov 26 14:19:13 volumio volumio[985]: info: ------------------------------ 0ms Nov 26 14:19:14 volumio volumio[985]: info: Nov 26 14:19:14 volumio volumio[985]: ---------------------------- MPD announces state update: player Nov 26 14:19:14 volumio volumio[985]: info: ControllerMpd::getState Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Nov 26 14:19:14 volumio volumio[985]: info: Nov 26 14:19:14 volumio volumio[985]: ---------------------------- MPD announces state update: player Nov 26 14:19:14 volumio volumio[985]: info: ControllerMpd::getState Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Nov 26 14:19:14 volumio volumio[985]: info: sendMpdCommand status took 4 milliseconds Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::parseState Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 14:19:14 volumio volumio[985]: info: Nov 26 14:19:14 volumio volumio[985]: ---------------------------- MPD announces state update: player Nov 26 14:19:14 volumio volumio[985]: info: ControllerMpd::getState Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Nov 26 14:19:14 volumio volumio[985]: info: sendMpdCommand status took 4 milliseconds Nov 26 14:19:14 volumio volumio[985]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::parseState Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Nov 26 14:19:14 volumio volumio[985]: info: ControllerMpd::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::servicePushState Nov 26 14:19:14 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:14 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":402,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mười Năm Tình Cũ","artist":"Chế Linh","album":"Chế Linh Đặc Biệt (Hát cho người tình phụ)","uri":"https://rr5---sn-8qj-i2ier.googlevideo.com/videoplayback?expire=1732627133&ei=XXZFZ5HBNvyg88EP99fh4Q4&ip=113.179.65.134&id=o-AIwlhlk2ygW6PMEZhRKnFfE1ssTURfz6ndIpctUWz4UX&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1732605533%2C&mh=NN&mm=31%2C29&mn=sn-8qj-i2ier%2Csn-8qj-i5ols&ms=au%2Crdu&mv=m&mvi=5&pl=23&rms=au%2Cau&gcr=vn&initcwndbps=1236250&bui=AQn3pFRYtA7khLZcFgF3YwL98WbaEcesjjjVzNzqLtXXNlxzrXrdltFqj8WdHwh6DK2WowMADErWo7-2&spc=qtApAbQc2Okm0HOE9e0o15og_OxlZwg9bxcUMinHB2_C51Sz4g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7MjxIgsOFKHGb1ekKmhL6YMQ&rqh=1&gir=yes&clen=6725255&dur=401.781&lmt=1714357383204806&mt=1732604960&fvip=6&keepalive=yes&fexp=51326932%2C51335594&c=WEB_REMIX&sefc=1&txp=2318224&n=tNM3FL1NnfjRng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRQIgR-6rKTBSb9zjH5Hg5sVUNc0IcMNhr1_rnru8cWQvxosCIQCk8-nfUcqV0ZxN-664Xlax_ZRPnbtUqPZfozjb2j2r9A%3D%3D&sig=AJfQdSswRgIhAMoKRXl1SJPzgsjtN-T1Xjpi1A0XsSEEIZlla8sc0pcrAiEAkCF81Hg3yE95PIjUVa_Io4bCuGxGzAlntyaz-fmODdQ%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Nov 26 14:19:14 volumio volumio[985]: verbose: CURRENT POSITION 0 Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus stop Nov 26 14:19:14 volumio volumio[985]: info: ------------------------------ 6ms Nov 26 14:19:14 volumio volumio[985]: info: Nov 26 14:19:14 volumio volumio[985]: ---------------------------- MPD announces state update: player Nov 26 14:19:14 volumio volumio[985]: info: ControllerMpd::getState Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Nov 26 14:19:14 volumio volumio[985]: info: sendMpdCommand status took 2 milliseconds Nov 26 14:19:14 volumio volumio[985]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 14:19:14 volumio volumio[985]: info: sendMpdCommand status took 1 milliseconds Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::parseState Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::parseState Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 14:19:14 volumio volumio[985]: info: ControllerMpd::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::servicePushState Nov 26 14:19:14 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:14 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":402,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mười Năm Tình Cũ","artist":"Chế Linh","album":"Chế Linh Đặc Biệt (Hát cho người tình phụ)","uri":"https://rr5---sn-8qj-i2ier.googlevideo.com/videoplayback?expire=1732627133&ei=XXZFZ5HBNvyg88EP99fh4Q4&ip=113.179.65.134&id=o-AIwlhlk2ygW6PMEZhRKnFfE1ssTURfz6ndIpctUWz4UX&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1732605533%2C&mh=NN&mm=31%2C29&mn=sn-8qj-i2ier%2Csn-8qj-i5ols&ms=au%2Crdu&mv=m&mvi=5&pl=23&rms=au%2Cau&gcr=vn&initcwndbps=1236250&bui=AQn3pFRYtA7khLZcFgF3YwL98WbaEcesjjjVzNzqLtXXNlxzrXrdltFqj8WdHwh6DK2WowMADErWo7-2&spc=qtApAbQc2Okm0HOE9e0o15og_OxlZwg9bxcUMinHB2_C51Sz4g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7MjxIgsOFKHGb1ekKmhL6YMQ&rqh=1&gir=yes&clen=6725255&dur=401.781&lmt=1714357383204806&mt=1732604960&fvip=6&keepalive=yes&fexp=51326932%2C51335594&c=WEB_REMIX&sefc=1&txp=2318224&n=tNM3FL1NnfjRng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRQIgR-6rKTBSb9zjH5Hg5sVUNc0IcMNhr1_rnru8cWQvxosCIQCk8-nfUcqV0ZxN-664Xlax_ZRPnbtUqPZfozjb2j2r9A%3D%3D&sig=AJfQdSswRgIhAMoKRXl1SJPzgsjtN-T1Xjpi1A0XsSEEIZlla8sc0pcrAiEAkCF81Hg3yE95PIjUVa_Io4bCuGxGzAlntyaz-fmODdQ%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Nov 26 14:19:14 volumio volumio[985]: verbose: CURRENT POSITION 0 Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus play Nov 26 14:19:14 volumio volumio[985]: info: Received an update from plugin. extracting info from payload Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:14 volumio volumio[985]: info: ------------------------------ 24ms Nov 26 14:19:14 volumio volumio[985]: info: sendMpdCommand playlistinfo took 18 milliseconds Nov 26 14:19:14 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Nov 26 14:19:14 volumio volumio[985]: info: ControllerMpd::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::servicePushState Nov 26 14:19:14 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:14 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":402,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mười Năm Tình Cũ","artist":"Chế Linh","album":"Chế Linh Đặc Biệt (Hát cho người tình phụ)","uri":"https://rr5---sn-8qj-i2ier.googlevideo.com/videoplayback?expire=1732627133&ei=XXZFZ5HBNvyg88EP99fh4Q4&ip=113.179.65.134&id=o-AIwlhlk2ygW6PMEZhRKnFfE1ssTURfz6ndIpctUWz4UX&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1732605533%2C&mh=NN&mm=31%2C29&mn=sn-8qj-i2ier%2Csn-8qj-i5ols&ms=au%2Crdu&mv=m&mvi=5&pl=23&rms=au%2Cau&gcr=vn&initcwndbps=1236250&bui=AQn3pFRYtA7khLZcFgF3YwL98WbaEcesjjjVzNzqLtXXNlxzrXrdltFqj8WdHwh6DK2WowMADErWo7-2&spc=qtApAbQc2Okm0HOE9e0o15og_OxlZwg9bxcUMinHB2_C51Sz4g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7MjxIgsOFKHGb1ekKmhL6YMQ&rqh=1&gir=yes&clen=6725255&dur=401.781&lmt=1714357383204806&mt=1732604960&fvip=6&keepalive=yes&fexp=51326932%2C51335594&c=WEB_REMIX&sefc=1&txp=2318224&n=tNM3FL1NnfjRng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRQIgR-6rKTBSb9zjH5Hg5sVUNc0IcMNhr1_rnru8cWQvxosCIQCk8-nfUcqV0ZxN-664Xlax_ZRPnbtUqPZfozjb2j2r9A%3D%3D&sig=AJfQdSswRgIhAMoKRXl1SJPzgsjtN-T1Xjpi1A0XsSEEIZlla8sc0pcrAiEAkCF81Hg3yE95PIjUVa_Io4bCuGxGzAlntyaz-fmODdQ%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Nov 26 14:19:14 volumio volumio[985]: verbose: CURRENT POSITION 0 Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus play Nov 26 14:19:14 volumio volumio[985]: info: Received an update from plugin. extracting info from payload Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:14 volumio volumio[985]: info: ControllerMpd::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::servicePushState Nov 26 14:19:14 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Nov 26 14:19:14 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":402,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mười Năm Tình Cũ","artist":"Chế Linh","album":"Chế Linh Đặc Biệt (Hát cho người tình phụ)","uri":"https://rr5---sn-8qj-i2ier.googlevideo.com/videoplayback?expire=1732627133&ei=XXZFZ5HBNvyg88EP99fh4Q4&ip=113.179.65.134&id=o-AIwlhlk2ygW6PMEZhRKnFfE1ssTURfz6ndIpctUWz4UX&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1732605533%2C&mh=NN&mm=31%2C29&mn=sn-8qj-i2ier%2Csn-8qj-i5ols&ms=au%2Crdu&mv=m&mvi=5&pl=23&rms=au%2Cau&gcr=vn&initcwndbps=1236250&bui=AQn3pFRYtA7khLZcFgF3YwL98WbaEcesjjjVzNzqLtXXNlxzrXrdltFqj8WdHwh6DK2WowMADErWo7-2&spc=qtApAbQc2Okm0HOE9e0o15og_OxlZwg9bxcUMinHB2_C51Sz4g&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=7MjxIgsOFKHGb1ekKmhL6YMQ&rqh=1&gir=yes&clen=6725255&dur=401.781&lmt=1714357383204806&mt=1732604960&fvip=6&keepalive=yes&fexp=51326932%2C51335594&c=WEB_REMIX&sefc=1&txp=2318224&n=tNM3FL1NnfjRng&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRQIgR-6rKTBSb9zjH5Hg5sVUNc0IcMNhr1_rnru8cWQvxosCIQCk8-nfUcqV0ZxN-664Xlax_ZRPnbtUqPZfozjb2j2r9A%3D%3D&sig=AJfQdSswRgIhAMoKRXl1SJPzgsjtN-T1Xjpi1A0XsSEEIZlla8sc0pcrAiEAkCF81Hg3yE95PIjUVa_Io4bCuGxGzAlntyaz-fmODdQ%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Nov 26 14:19:14 volumio volumio[985]: verbose: CURRENT POSITION 0 Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus play Nov 26 14:19:14 volumio volumio[985]: info: Received an update from plugin. extracting info from payload Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:14 volumio volumio[985]: info: CoreStateMachine::pushState Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output update for this device Nov 26 14:19:14 volumio volumio[985]: info: MRS: Pushing multiroomSync output Nov 26 14:19:14 volumio volumio[985]: info: ------------------------------ 58ms Nov 26 14:19:14 volumio volumio[985]: info: ------------------------------ 58ms Nov 26 14:19:14 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:14 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:14 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:14 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:14 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:14 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 26 14:19:14 volumio volumio[985]: info: Executing endpoint metavolumio Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 26 14:19:14 volumio volumio[985]: info: Executing endpoint metavolumio Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 26 14:19:14 volumio volumio[985]: info: Executing endpoint metavolumio Nov 26 14:19:14 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 26 14:19:15 volumio ntpd[1285]: Soliciting pool server 2404:fbc0:0:2046::c Nov 26 14:19:20 volumio ntpd[1285]: Soliciting pool server 27.71.27.209 Nov 26 14:19:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 14:19:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 14:19:21 volumio volumio[985]: info: Discovery: Getting this device information Nov 26 14:19:21 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Nov 26 14:19:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 14:19:22 volumio ntpd[1285]: Soliciting pool server 103.130.217.41 Nov 26 14:19:28 volumio ntpd[1285]: Soliciting pool server 103.130.217.41 Nov 26 14:19:51 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 14:19:51 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 14:19:51 volumio volumio[985]: info: Discovery: Getting this device information Nov 26 14:19:51 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Nov 26 14:19:51 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 14:20:07 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 26 14:20:07 volumio volumio[985]: info: CURURI: playlists/Phuong phuong thao Nov 26 14:20:07 volumio volumio[985]: info: Preload queue cleared Nov 26 14:20:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 14:20:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 14:20:21 volumio volumio[985]: info: Discovery: Getting this device information Nov 26 14:20:21 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Nov 26 14:20:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 14:20:21 volumio ntpd[1285]: Soliciting pool server 2a0c:b847:ffff:79::e53c Nov 26 14:20:24 volumio ntpd[1285]: Soliciting pool server 103.130.217.41 Nov 26 14:20:28 volumio ntpd[1285]: Soliciting pool server 103.184.124.23 Nov 26 14:20:34 volumio ntpd[1285]: Soliciting pool server 103.184.124.23 Nov 26 14:20:38 volumio volumio[985]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 14:20:38 volumio volumio[985]: Error: connect ETIMEDOUT 151.101.194.79:80 Nov 26 14:20:38 volumio volumio[985]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Nov 26 14:20:38 volumio volumio[985]: errno: -110, Nov 26 14:20:38 volumio volumio[985]: code: 'ETIMEDOUT', Nov 26 14:20:38 volumio volumio[985]: syscall: 'connect', Nov 26 14:20:38 volumio volumio[985]: address: '151.101.194.79', Nov 26 14:20:38 volumio volumio[985]: port: 80 Nov 26 14:20:38 volumio volumio[985]: } Nov 26 14:20:38 volumio volumio[985]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 14:20:38 volumio sudo[4025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 14:19 Nov 26 14:20:38 volumio sudo[4025]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"