-- Logs begin at Sun 2025-05-04 19:38:14 +07, end at Sun 2025-05-04 20:12:20 +07. -- May 04 20:11:01 volumio ntpd[1501]: Soliciting pool server 115.165.161.155 May 04 20:11:01 volumio volumio[1116]: Searching all installed plugins May 04 20:11:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 20:11:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: , search May 04 20:11:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 04 20:11:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 04 20:11:01 volumio volumio[1116]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 04 20:11:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 04 20:11:01 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 04 20:11:02 volumio ntpd[1501]: Soliciting pool server 115.165.161.155 May 04 20:11:02 volumio volumio[1116]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 04 20:11:02 volumio volumio[1116]: command_run: { startIndex: 0, length: 40, onTap: { innertubeCommand: [Object] } }, May 04 20:11:02 volumio volumio[1116]: input_data: { May 04 20:11:02 volumio volumio[1116]: content: 'MIN - TÌM (LOST) (ft. MR.A) M/V · 4:34', May 04 20:11:02 volumio volumio[1116]: commandRuns: [ [Object] ] May 04 20:11:02 volumio volumio[1116]: }, May 04 20:11:02 volumio volumio[1116]: parsed_runs: [ { text: 'MIN - TÌM (LOST) (ft. MR.A) M/V · 4:34', startIndex: 0 } ] May 04 20:11:02 volumio volumio[1116]: } May 04 20:11:02 volumio volumio[1116]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 04 20:11:02 volumio volumio[1116]: command_run: { startIndex: 0, length: 73, onTap: { innertubeCommand: [Object] } }, May 04 20:11:02 volumio volumio[1116]: input_data: { May 04 20:11:02 volumio volumio[1116]: content: 'MIN - TRÊN TÌNH BẠN DƯỚI TÌNH YÊU | OFFICIAL MUSIC VIDEO · 4:54', May 04 20:11:02 volumio volumio[1116]: commandRuns: [ [Object] ] May 04 20:11:02 volumio volumio[1116]: }, May 04 20:11:02 volumio volumio[1116]: parsed_runs: [ May 04 20:11:02 volumio volumio[1116]: { May 04 20:11:02 volumio volumio[1116]: text: 'MIN - TRÊN TÌNH BẠN DƯỚI TÌNH YÊU | OFFICIAL MUSIC VIDEO · 4:54', May 04 20:11:02 volumio volumio[1116]: startIndex: 0 May 04 20:11:02 volumio volumio[1116]: } May 04 20:11:02 volumio volumio[1116]: ] May 04 20:11:02 volumio volumio[1116]: } May 04 20:11:02 volumio volumio[1116]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 04 20:11:02 volumio volumio[1116]: command_run: { startIndex: 0, length: 119, onTap: { innertubeCommand: [Object] } }, May 04 20:11:02 volumio volumio[1116]: input_data: { May 04 20:11:02 volumio volumio[1116]: content: 'VÔ TÌNH TÌM THẤY HARU - TẬP 01 [Lồng Tiếng] Top 1 Phim Bộ Tình Cảm Hàn Quốc Hay Nhất 2025 · 42:35', May 04 20:11:02 volumio volumio[1116]: commandRuns: [ [Object] ] May 04 20:11:02 volumio volumio[1116]: }, May 04 20:11:02 volumio volumio[1116]: parsed_runs: [ May 04 20:11:02 volumio volumio[1116]: { May 04 20:11:02 volumio volumio[1116]: text: 'VÔ TÌNH TÌM THẤY HARU - TẬP 01 [Lồng Tiếng] Top 1 Phim Bộ Tình Cảm Hàn Quốc Hay Nhất 2025 · 42:35', May 04 20:11:02 volumio volumio[1116]: startIndex: 0 May 04 20:11:02 volumio volumio[1116]: } May 04 20:11:02 volumio volumio[1116]: ] May 04 20:11:02 volumio volumio[1116]: } May 04 20:11:02 volumio volumio[1116]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 04 20:11:02 volumio volumio[1116]: command_run: { startIndex: 0, length: 131, onTap: { innertubeCommand: [Object] } }, May 04 20:11:02 volumio volumio[1116]: input_data: { May 04 20:11:02 volumio volumio[1116]: content: 'KHÔNG CÓ LẦN THỨ HAI - Tập 01 [Lồng Tiếng] Trọn Bộ Phim Tình Cảm Tâm Lý Hàn Quốc Mới Nhất 2025 · 52:19', May 04 20:11:02 volumio volumio[1116]: commandRuns: [ [Object] ] May 04 20:11:02 volumio volumio[1116]: }, May 04 20:11:02 volumio volumio[1116]: parsed_runs: [ May 04 20:11:02 volumio volumio[1116]: { May 04 20:11:02 volumio volumio[1116]: text: 'KHÔNG CÓ LẦN THỨ HAI - Tập 01 [Lồng Tiếng] Trọn Bộ Phim Tình Cảm Tâm Lý Hàn Quốc Mới Nhất 2025 · 52:19', May 04 20:11:02 volumio volumio[1116]: startIndex: 0 May 04 20:11:02 volumio volumio[1116]: } May 04 20:11:02 volumio volumio[1116]: ] May 04 20:11:02 volumio volumio[1116]: } May 04 20:11:02 volumio volumio[1116]: info: All search sources collected, pushing search results May 04 20:11:02 volumio volumio[1116]: Searching all installed plugins May 04 20:11:02 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 20:11:02 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: , search May 04 20:11:02 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 04 20:11:02 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 04 20:11:02 volumio volumio[1116]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 04 20:11:02 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 04 20:11:02 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 04 20:11:03 volumio volumio[1116]: info: All search sources collected, pushing search results May 04 20:11:05 volumio volumio[1116]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Linda%20Chou/Secret/196b4177-b11f-48f6-a07b-5a1b9d8b9961.jpg' May 04 20:11:06 volumio ntpd[1501]: Soliciting pool server 27.71.27.209 May 04 20:11:11 volumio ntpd[1501]: Soliciting pool server 2401:5f80:5001:1f::31f May 04 20:11:11 volumio volumio[1116]: Searching all installed plugins May 04 20:11:11 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 20:11:11 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: , search May 04 20:11:11 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 04 20:11:11 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 04 20:11:11 volumio volumio[1116]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 04 20:11:11 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 04 20:11:11 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 04 20:11:11 volumio volumio[1116]: info: All search sources collected, pushing search results May 04 20:11:13 volumio volumio[1116]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' May 04 20:11:13 volumio volumio[1116]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' May 04 20:11:13 volumio volumio[1116]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' May 04 20:11:14 volumio volumio[1116]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' May 04 20:11:14 volumio volumio[1116]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' May 04 20:11:14 volumio volumio[1116]: Searching all installed plugins May 04 20:11:14 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 20:11:14 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: , search May 04 20:11:14 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 04 20:11:14 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: last_100 , search May 04 20:11:14 volumio volumio[1116]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 May 04 20:11:14 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 04 20:11:14 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search May 04 20:11:15 volumio volumio[1116]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 04 20:11:15 volumio volumio[1116]: command_run: { startIndex: 0, length: 65, onTap: { innertubeCommand: [Object] } }, May 04 20:11:15 volumio volumio[1116]: input_data: { May 04 20:11:15 volumio volumio[1116]: content: 'TÌM VỀ - HƯƠNG LY | OST CHA TÔI, NGƯỜI Ở LẠI · 4:52', May 04 20:11:15 volumio volumio[1116]: commandRuns: [ [Object] ] May 04 20:11:15 volumio volumio[1116]: }, May 04 20:11:15 volumio volumio[1116]: parsed_runs: [ May 04 20:11:15 volumio volumio[1116]: { May 04 20:11:15 volumio volumio[1116]: text: 'TÌM VỀ - HƯƠNG LY | OST CHA TÔI, NGƯỜI Ở LẠI · 4:52', May 04 20:11:15 volumio volumio[1116]: startIndex: 0 May 04 20:11:15 volumio volumio[1116]: } May 04 20:11:15 volumio volumio[1116]: ] May 04 20:11:15 volumio volumio[1116]: } May 04 20:11:15 volumio volumio[1116]: [YOUTUBEJS][Text]: Unable to find matching run for command run. Skipping... { May 04 20:11:15 volumio volumio[1116]: command_run: { startIndex: 0, length: 64, onTap: { innertubeCommand: [Object] } }, May 04 20:11:15 volumio volumio[1116]: input_data: { May 04 20:11:15 volumio volumio[1116]: content: 'CẨM TÚ CẦU | RAYO x HUỲNH VĂN | HƯƠNG LY COVER · 4:52', May 04 20:11:15 volumio volumio[1116]: commandRuns: [ [Object] ] May 04 20:11:15 volumio volumio[1116]: }, May 04 20:11:15 volumio volumio[1116]: parsed_runs: [ May 04 20:11:15 volumio volumio[1116]: { May 04 20:11:15 volumio volumio[1116]: text: 'CẨM TÚ CẦU | RAYO x HUỲNH VĂN | HƯƠNG LY COVER · 4:52', May 04 20:11:15 volumio volumio[1116]: startIndex: 0 May 04 20:11:15 volumio volumio[1116]: } May 04 20:11:15 volumio volumio[1116]: ] May 04 20:11:15 volumio volumio[1116]: } May 04 20:11:15 volumio volumio[1116]: info: All search sources collected, pushing search results May 04 20:11:21 volumio volumio[1116]: info: Preload queue cleared May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioReplaceandPlayItems May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::ClearQueue May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::stop May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::stPlaybackTimer May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::updateTrackBlock May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrackBlock May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 5 May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::serviceStop May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 5 May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::serviceStop May 04 20:11:21 volumio volumio[1116]: info: ControllerMpd::stop May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand stop May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::clearPlayQueue May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::saveQueue May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushQueue May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::addQueueItems May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::addQueueItems May 04 20:11:21 volumio volumio[1116]: info: Preload queue cleared May 04 20:11:21 volumio volumio[1116]: info: Adding Item to queue: albums://Huong%20Ly%2C%20Ti%E1%BA%BFn%20Minh/T%C3%ACm%20V%E1%BB%81%20(Cha%20T%C3%B4i%20Ng%C6%B0%E1%BB%9Di%20%E1%BB%9E%20L%E1%BA%A1i) May 04 20:11:21 volumio volumio[1116]: info: Exploding uri albums://Huong%20Ly%2C%20Ti%E1%BA%BFn%20Minh/T%C3%ACm%20V%E1%BB%81%20(Cha%20T%C3%B4i%20Ng%C6%B0%E1%BB%9Di%20%E1%BB%9E%20L%E1%BA%A1i) in service mpd May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushQueue May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::saveQueue May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::updateTrackBlock May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrackBlock May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPlay May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::play index 0 May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::stop May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::play index undefined May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::startPlaybackTimer May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::clearAddPlayTracks NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand stop May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand stop took 29 milliseconds May 04 20:11:21 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand stop took 2 milliseconds May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand clear May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:21 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:21 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces system playlist update May 04 20:11:21 volumio volumio[1116]: info: Ignoring MPD Status Update May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand status took 6 milliseconds May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand clear took 5 milliseconds May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand status took 3 milliseconds May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand status took 2 milliseconds May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::parseState May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand add "NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac" May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::parseState May 04 20:11:21 volumio volumio[1116]: info: ControllerMpd::pushState May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::servicePushState May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: 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} May 04 20:11:21 volumio volumio[1116]: verbose: CURRENT POSITION 0 May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::syncState stateService stop May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::syncState currentStatus stop May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:21 volumio volumio[1116]: info: No code May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:21 volumio volumio[1116]: info: ControllerMpd::pushState May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::servicePushState May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: 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} May 04 20:11:21 volumio volumio[1116]: verbose: CURRENT POSITION 0 May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::syncState stateService stop May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::syncState currentStatus stop May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:21 volumio volumio[1116]: info: No code May 04 20:11:21 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:21 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:21 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:21 volumio volumio[1116]: info: ------------------------------ 46ms May 04 20:11:21 volumio volumio[1116]: info: ------------------------------ 46ms May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces system playlist update May 04 20:11:21 volumio volumio[1116]: info: Ignoring MPD Status Update May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces system playlist update May 04 20:11:21 volumio volumio[1116]: info: Ignoring MPD Status Update May 04 20:11:21 volumio volumio[1116]: error: updateQueue error: null May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces system playlist update May 04 20:11:21 volumio volumio[1116]: info: Ignoring MPD Status Update May 04 20:11:21 volumio volumio[1116]: info: ------------------------------ 50ms May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand playlistinfo took 49 milliseconds May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand add "NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac" took 49 milliseconds May 04 20:11:21 volumio volumio[1116]: info: ------------------------------ 6ms May 04 20:11:21 volumio volumio[1116]: info: ------------------------------ 5ms May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::parseTrackInfo May 04 20:11:21 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand play May 04 20:11:21 volumio volumio[1116]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 04 20:11:21 volumio volumio[1116]: info: ------------------------------ 59ms May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces system playlist update May 04 20:11:21 volumio volumio[1116]: info: Ignoring MPD Status Update May 04 20:11:21 volumio volumio[1116]: info: May 04 20:11:21 volumio volumio[1116]: ---------------------------- MPD announces system playlist update May 04 20:11:21 volumio volumio[1116]: info: Ignoring MPD Status Update May 04 20:11:21 volumio volumio[1116]: info: ------------------------------ 13ms May 04 20:11:21 volumio volumio[1116]: info: sendMpdCommand play took 11 milliseconds May 04 20:11:21 volumio volumio[1116]: info: ------------------------------ 9ms May 04 20:11:22 volumio volumio[1116]: info: May 04 20:11:22 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:22 volumio volumio[1116]: info: May 04 20:11:22 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:22 volumio volumio[1116]: info: May 04 20:11:22 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:22 volumio volumio[1116]: info: May 04 20:11:22 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand status took 11 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand status took 8 milliseconds May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 20:11:22 volumio volumio[1116]: info: May 04 20:11:22 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:22 volumio volumio[1116]: info: May 04 20:11:22 volumio volumio[1116]: ---------------------------- MPD announces state update: player May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::getState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand status May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand status took 15 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand status took 13 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand playlistinfo took 9 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand playlistinfo took 9 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand status took 6 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand status took 4 milliseconds May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseTrackInfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseTrackInfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseState May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::pushState May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::servicePushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"104 Kbps","isStreaming":false,"title":"Tìm Về","artist":"Huong Ly, Tiến Minh","album":"Tìm Về (Cha Tôi Người Ở Lại)","uri":"NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac","trackType":"flac"} May 04 20:11:22 volumio volumio[1116]: verbose: CURRENT POSITION 0 May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState stateService play May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState currentStatus stop May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::pushState May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::servicePushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"104 Kbps","isStreaming":false,"title":"Tìm Về","artist":"Huong Ly, Tiến Minh","album":"Tìm Về (Cha Tôi Người Ở Lại)","uri":"NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac","trackType":"flac"} May 04 20:11:22 volumio volumio[1116]: verbose: CURRENT POSITION 0 May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState stateService play May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState currentStatus play May 04 20:11:22 volumio volumio[1116]: info: Received an update from plugin. extracting info from payload May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: ------------------------------ 49ms May 04 20:11:22 volumio volumio[1116]: info: ------------------------------ 54ms May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand playlistinfo took 30 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand playlistinfo took 29 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand playlistinfo took 29 milliseconds May 04 20:11:22 volumio volumio[1116]: info: sendMpdCommand playlistinfo took 28 milliseconds May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseTrackInfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseTrackInfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseTrackInfo May 04 20:11:22 volumio volumio[1116]: verbose: ControllerMpd::parseTrackInfo May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::pushState May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::servicePushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"104 Kbps","isStreaming":false,"title":"Tìm Về","artist":"Huong Ly, Tiến Minh","album":"Tìm Về (Cha Tôi Người Ở Lại)","uri":"NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac","trackType":"flac"} May 04 20:11:22 volumio volumio[1116]: verbose: CURRENT POSITION 0 May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState stateService play May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState currentStatus play May 04 20:11:22 volumio volumio[1116]: info: Received an update from plugin. extracting info from payload May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::pushState May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::servicePushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"104 Kbps","isStreaming":false,"title":"Tìm Về","artist":"Huong Ly, Tiến Minh","album":"Tìm Về (Cha Tôi Người Ở Lại)","uri":"NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac","trackType":"flac"} May 04 20:11:22 volumio volumio[1116]: verbose: CURRENT POSITION 0 May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState stateService play May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState currentStatus play May 04 20:11:22 volumio volumio[1116]: info: Received an update from plugin. extracting info from payload May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::pushState May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::servicePushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"104 Kbps","isStreaming":false,"title":"Tìm Về","artist":"Huong Ly, Tiến Minh","album":"Tìm Về (Cha Tôi Người Ở Lại)","uri":"NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac","trackType":"flac"} May 04 20:11:22 volumio volumio[1116]: verbose: CURRENT POSITION 0 May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState stateService play May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState currentStatus play May 04 20:11:22 volumio volumio[1116]: info: Received an update from plugin. extracting info from payload May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: ControllerMpd::pushState May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::servicePushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"104 Kbps","isStreaming":false,"title":"Tìm Về","artist":"Huong Ly, Tiến Minh","album":"Tìm Về (Cha Tôi Người Ở Lại)","uri":"NAS/Goflex_Home/Music/Huong Ly - Tìm Về.flac","trackType":"flac"} May 04 20:11:22 volumio volumio[1116]: verbose: CURRENT POSITION 0 May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState stateService play May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::syncState currentStatus play May 04 20:11:22 volumio volumio[1116]: info: Received an update from plugin. extracting info from payload May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: CoreStateMachine::pushState May 04 20:11:22 volumio volumio[1116]: info: CorePlayQueue::getTrack 0 May 04 20:11:22 volumio volumio[1116]: info: CoreCommandRouter::volumioPushState May 04 20:11:22 volumio volumio[1116]: info: ------------------------------ 113ms May 04 20:11:22 volumio volumio[1116]: info: ------------------------------ 111ms May 04 20:11:22 volumio volumio[1116]: info: ------------------------------ 103ms May 04 20:11:22 volumio volumio[1116]: info: ------------------------------ 102ms May 04 20:12:05 volumio ntpd[1501]: Soliciting pool server 27.71.27.209 May 04 20:12:09 volumio ntpd[1501]: Soliciting pool server 103.184.124.254 May 04 20:12:12 volumio ntpd[1501]: Soliciting pool server 115.165.161.155 May 04 20:12:18 volumio ntpd[1501]: Soliciting pool server 2404:fbc0:0:2046::c May 04 20:12:20 volumio volumio[1116]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 20:12:20 volumio volumio[1116]: Error: connect ETIMEDOUT 151.101.78.79:443 May 04 20:12:20 volumio volumio[1116]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 04 20:12:20 volumio volumio[1116]: errno: -110, May 04 20:12:20 volumio volumio[1116]: code: 'ETIMEDOUT', May 04 20:12:20 volumio volumio[1116]: syscall: 'connect', May 04 20:12:20 volumio volumio[1116]: address: '151.101.78.79', May 04 20:12:20 volumio volumio[1116]: port: 443 May 04 20:12:20 volumio volumio[1116]: } May 04 20:12:20 volumio volumio[1116]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 20:12:20 volumio sudo[6798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 20:11 May 04 20:12:20 volumio sudo[6798]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"