-- Logs begin at Sat 2024-10-26 10:19:38 CST, end at Sat 2024-10-26 10:27:59 CST. -- Oct 26 10:26:08 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 10:26:08 volumio volumio[2416]: info: CURURI: music-library Oct 26 10:26:08 volumio volumio[2416]: info: Preload queue cleared Oct 26 10:26:09 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 10:26:09 volumio volumio[2416]: info: CURURI: music-library/USB Oct 26 10:26:09 volumio volumio[2416]: info: Preload queue cleared Oct 26 10:26:12 volumio volumio[2416]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Oct 26 10:26:12 volumio volumio[2416]: info: Retrying Login Due to Network Error Oct 26 10:26:16 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 10:26:16 volumio volumio[2416]: info: CURURI: music-library/USB/daphile Oct 26 10:26:16 volumio volumio[2416]: info: Preload queue cleared Oct 26 10:26:17 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 26 10:26:17 volumio volumio[2416]: info: CURURI: music-library/USB/daphile/00中文歌曲 Oct 26 10:26:17 volumio volumio[2416]: info: Preload queue cleared Oct 26 10:26:22 volumio volumio[2416]: info: MyVolumio login type: Token Oct 26 10:26:27 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E5%90%89%E7%A5%A5%E5%A6%82%E6%84%8F/1a456494-07a0-4d4b-b5cb-29ceae061ede.jpg' Oct 26 10:26:27 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E5%90%89%E7%A5%A5%E5%A6%82%E6%84%8F/1a456494-07a0-4d4b-b5cb-29ceae061ede.jpg' Oct 26 10:26:30 volumio volumio[2416]: info: VolumeController::SetAlsaVolume100 Oct 26 10:26:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:26:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:26:30 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:26:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:26:30 volumio volumio[2416]: info: VolumeController::SetAlsaVolume100 Oct 26 10:26:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:26:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:26:30 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:26:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:26:30 volumio volumio[2416]: info: VolumeController::SetAlsaVolume100 Oct 26 10:26:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:26:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:26:30 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:26:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:26:31 volumio volumio[2416]: info: VolumeController::SetAlsaVolume100 Oct 26 10:26:31 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:26:31 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:26:31 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:26:31 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:26:52 volumio volumio[2416]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Oct 26 10:26:52 volumio volumio[2416]: info: Retrying Login Due to Network Error Oct 26 10:27:02 volumio volumio[2416]: info: MyVolumio login type: Token Oct 26 10:27:09 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:09 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%88%E4%BA%AE%E4%B9%8B%E4%B8%8A/8c779401-7255-4eaf-887d-76388eab0782.jpg' Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:27:10 volumio volumio[2416]: info: Discovery: Getting this device information Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::volumioGetState Oct 26 10:27:10 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:27:10 volumio volumio[2416]: verbose: New Socket.io Connection to 192.168.31.34 from 192.168.31.135 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 8 Oct 26 10:27:10 volumio volumio[2416]: verbose: New Socket.io Connection to 192.168.31.34 from 192.168.31.135 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 9 Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::volumioGetState Oct 26 10:27:10 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::volumioGetState Oct 26 10:27:10 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:10 volumio volumio[2416]: verbose: New Socket.io Connection to 192.168.31.34 from 192.168.31.135 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 10 Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 10:27:10 volumio volumio[2416]: info: Listing playlists Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 10:27:10 volumio volumio[2416]: info: CoreCommandRouter::volumioGetQueue Oct 26 10:27:10 volumio volumio[2416]: info: CoreStateMachine::getQueue Oct 26 10:27:10 volumio volumio[2416]: info: CorePlayQueue::getQueue Oct 26 10:27:11 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E5%90%89%E7%A5%A5%E5%A6%82%E6%84%8F/1a456494-07a0-4d4b-b5cb-29ceae061ede.jpg' Oct 26 10:27:11 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:11 volumio volumio[2416]: info: VolumeController::SetAlsaVolume90 Oct 26 10:27:11 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:11 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:11 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:11 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:11 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%88%E4%BA%AE%E4%B9%8B%E4%B8%8A/8c779401-7255-4eaf-887d-76388eab0782.jpg' Oct 26 10:27:11 volumio volumio[2416]: info: VolumeController::SetAlsaVolume70 Oct 26 10:27:11 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:11 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:11 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:11 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:11 volumio volumio[2416]: info: VolumeController::SetAlsaVolume65 Oct 26 10:27:11 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:11 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:11 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:11 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:12 volumio volumio[2416]: info: VolumeController::SetAlsaVolume60 Oct 26 10:27:12 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:12 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:12 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:12 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:12 volumio volumio[2416]: info: VolumeController::SetAlsaVolume50 Oct 26 10:27:12 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:12 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:12 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:12 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:13 volumio volumio[2416]: info: VolumeController::SetAlsaVolume45 Oct 26 10:27:13 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:13 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:13 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:13 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:13 volumio volumio[2416]: info: VolumeController::SetAlsaVolume50 Oct 26 10:27:13 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:13 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:13 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:13 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:13 volumio volumio[2416]: info: VolumeController::SetAlsaVolume55 Oct 26 10:27:13 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:13 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:13 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:13 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::volumioPlay Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::play index 12 Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::stop Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::stPlaybackTimer Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::updateTrackBlock Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrackBlock Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::serviceStop Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrack 0 Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::serviceStop Oct 26 10:27:29 volumio volumio[2416]: info: ControllerMpd::stop Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand stop took 30 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::play index undefined Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::startPlaybackTimer Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::clearAddPlayTracks USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:29 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:29 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:29 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:29 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:29 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand status took 29 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand stop took 24 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand status took 18 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand status took 16 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand status took 15 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand status took 11 milliseconds Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand clear Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand status took 25 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 22 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand clear took 22 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 23 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 22 milliseconds Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand add "USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac" Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:29 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:29 volumio volumio[2416]: 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":"一代天骄","artist":"凤凰传奇","album":"吉祥如意","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 一代天骄.flac","trackType":"flac"} Oct 26 10:27:29 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::syncState stateService stop Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus stop Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:29 volumio volumio[2416]: info: No code Oct 26 10:27:29 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:29 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:29 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:29 volumio volumio[2416]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 26 10:27:29 volumio volumio[2416]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 26 10:27:29 volumio volumio[2416]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 26 10:27:29 volumio volumio[2416]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 140ms Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 128ms Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 124ms Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 120ms Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 116ms Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: error: updateQueue error: null Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 118ms Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 104 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: sendMpdCommand add "USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac" took 104 milliseconds Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 28ms Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 22ms Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 18ms Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 14ms Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 10ms Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:29 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand play Oct 26 10:27:29 volumio volumio[2416]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 26 10:27:29 volumio volumio[2416]: info: ------------------------------ 153ms Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:29 volumio volumio[2416]: info: Oct 26 10:27:29 volumio volumio[2416]: ---------------------------- MPD announces system playlist update Oct 26 10:27:29 volumio volumio[2416]: info: Ignoring MPD Status Update Oct 26 10:27:30 volumio volumio[2416]: info: Oct 26 10:27:30 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:30 volumio volumio[2416]: info: Oct 26 10:27:30 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 162ms Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand play took 150 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 160ms Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 155ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 150ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 148ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 136ms Oct 26 10:27:30 volumio volumio[2416]: info: Oct 26 10:27:30 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:30 volumio volumio[2416]: info: Oct 26 10:27:30 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:30 volumio volumio[2416]: info: Oct 26 10:27:30 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:30 volumio volumio[2416]: info: Oct 26 10:27:30 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:30 volumio volumio[2416]: info: Oct 26 10:27:30 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand status took 189 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand status took 181 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand status took 162 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand status took 161 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand status took 154 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand status took 147 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand status took 139 milliseconds Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:30 volumio volumio[2416]: info: Oct 26 10:27:30 volumio volumio[2416]: ---------------------------- MPD announces state update: player Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::getState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 120 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 132 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 141 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 141 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 141 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 141 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 140 milliseconds Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand status took 134 milliseconds Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseState Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"825 Kbps","isStreaming":false,"title":"奢香夫人","artist":"凤凰传奇","album":"最炫民族风","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac","trackType":"flac"} Oct 26 10:27:30 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState stateService play Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus stop Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"825 Kbps","isStreaming":false,"title":"奢香夫人","artist":"凤凰传奇","album":"最炫民族风","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac","trackType":"flac"} Oct 26 10:27:30 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState stateService play Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:27:30 volumio volumio[2416]: info: Received an update from plugin. extracting info from payload Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":387,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"825 Kbps","isStreaming":false,"title":"奢香夫人","artist":"凤凰传奇","album":"最炫民族风","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac","trackType":"flac"} Oct 26 10:27:30 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState stateService play Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:27:30 volumio volumio[2416]: info: Received an update from plugin. extracting info from payload Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":409,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"683 Kbps","isStreaming":false,"title":"奢香夫人","artist":"凤凰传奇","album":"最炫民族风","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac","trackType":"flac"} Oct 26 10:27:30 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState stateService play Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:27:30 volumio volumio[2416]: info: Received an update from plugin. extracting info from payload Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":409,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"683 Kbps","isStreaming":false,"title":"奢香夫人","artist":"凤凰传奇","album":"最炫民族风","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac","trackType":"flac"} Oct 26 10:27:30 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState stateService play Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:27:30 volumio volumio[2416]: info: Received an update from plugin. extracting info from payload Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"683 Kbps","isStreaming":false,"title":"奢香夫人","artist":"凤凰传奇","album":"最炫民族风","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac","trackType":"flac"} Oct 26 10:27:30 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState stateService play Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:27:30 volumio volumio[2416]: info: Received an update from plugin. extracting info from payload Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"683 Kbps","isStreaming":false,"title":"奢香夫人","artist":"凤凰传奇","album":"最炫民族风","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac","trackType":"flac"} Oct 26 10:27:30 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState stateService play Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:27:30 volumio volumio[2416]: info: Received an update from plugin. extracting info from payload Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 496ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 615ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 588ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 571ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 566ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 559ms Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 552ms Oct 26 10:27:30 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:30 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:30 volumio volumio[2416]: info: sendMpdCommand playlistinfo took 269 milliseconds Oct 26 10:27:30 volumio volumio[2416]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:27:30 volumio volumio[2416]: info: ControllerMpd::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::servicePushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"609 Kbps","isStreaming":false,"title":"奢香夫人","artist":"凤凰传奇","album":"最炫民族风","uri":"USB/daphile/00中文歌曲/凤凰传奇/凤凰传奇/凤凰传奇 - 奢香夫人.flac","trackType":"flac"} Oct 26 10:27:30 volumio volumio[2416]: verbose: CURRENT POSITION 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState stateService play Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:27:30 volumio volumio[2416]: info: Received an update from plugin. extracting info from payload Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:30 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:30 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:30 volumio volumio[2416]: info: ------------------------------ 501ms Oct 26 10:27:31 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:31 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:31 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:32 volumio volumio[2416]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Oct 26 10:27:32 volumio volumio[2416]: info: Retrying Login Due to Network Error Oct 26 10:27:33 volumio volumio[2416]: info: VolumeController::SetAlsaVolume65 Oct 26 10:27:33 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:33 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:33 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:33 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:33 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:33 volumio volumio[2416]: info: VolumeController::SetAlsaVolume65 Oct 26 10:27:33 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:33 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:33 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:33 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:33 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:34 volumio volumio[2416]: info: VolumeController::SetAlsaVolume75 Oct 26 10:27:34 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:34 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:34 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:34 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:34 volumio volumio[2416]: info: VolumeController::SetAlsaVolume75 Oct 26 10:27:34 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:34 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:34 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:34 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:34 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:34 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:34 volumio volumio[2416]: info: VolumeController::SetAlsaVolume85 Oct 26 10:27:34 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:34 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:34 volumio volumio[2416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:27:34 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:34 volumio volumio[2416]: info: VolumeController::SetAlsaVolume85 Oct 26 10:27:34 volumio volumio[2416]: info: CoreStateMachine::pushState Oct 26 10:27:34 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:34 volumio volumio[2416]: info: CoreCommandRouter::volumioPushState Oct 26 10:27:42 volumio volumio[2416]: info: MyVolumio login type: Token Oct 26 10:27:44 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:51 volumio volumio[2416]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Oct 26 10:27:51 volumio volumio[2416]: info: CoreCommandRouter::volumioGetState Oct 26 10:27:51 volumio volumio[2416]: info: CorePlayQueue::getTrack 12 Oct 26 10:27:51 volumio volumio[2416]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/8ced0677-5454-4a49-ae69-d73e9ea64790.jpg' Oct 26 10:27:58 volumio volumio[2416]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 10:27:58 volumio volumio[2416]: Error: connect ETIMEDOUT 108.160.167.159:443 Oct 26 10:27:58 volumio volumio[2416]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 26 10:27:58 volumio volumio[2416]: errno: -110, Oct 26 10:27:58 volumio volumio[2416]: code: 'ETIMEDOUT', Oct 26 10:27:58 volumio volumio[2416]: syscall: 'connect', Oct 26 10:27:58 volumio volumio[2416]: address: '108.160.167.159', Oct 26 10:27:58 volumio volumio[2416]: port: 443 Oct 26 10:27:58 volumio volumio[2416]: } Oct 26 10:27:58 volumio volumio[2416]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 10:27:59 volumio sudo[5043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 10:26 Oct 26 10:27:59 volumio sudo[5043]: 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"