-- Logs begin at Fri 2024-11-01 13:48:57 CST, end at Fri 2024-11-01 14:35:57 CST. -- Nov 01 14:34:00 volumio-603 volumio[1092]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 01 14:34:00 volumio-603 volumio[1092]: info: Retrying Login Due to Network Error Nov 01 14:34:00 volumio-603 volumiologrotate[701]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Nov 01 14:34:00 volumio-603 volumiologrotate[701]: ls: cannot access '603': No such file or directory Nov 01 14:34:02 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 14:34:03 volumio-603 volumio[1092]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.10 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) FxiOS/131.4 Mobile/15E148 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 10 Nov 01 14:34:03 volumio-603 volumio[1092]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.10 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) FxiOS/131.4 Mobile/15E148 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 11 Nov 01 14:34:03 volumio-603 volumio[1092]: info: Received Get System Info Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 14:34:03 volumio-603 volumio[1092]: info: Discovery: Getting this device information Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:03 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:03 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:03 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 14:34:03 volumio-603 volumio[1092]: info: Received Get System Info Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 14:34:03 volumio-603 volumio[1092]: info: Discovery: Getting this device information Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:03 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:03 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:03 volumio-603 volumio[1092]: info: Listing playlists Nov 01 14:34:03 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 01 14:34:06 volumio-603 volumio[1092]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.10 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) FxiOS/131.4 Mobile/15E148 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 12 Nov 01 14:34:06 volumio-603 volumio[1092]: info: Received Get System Info Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 14:34:06 volumio-603 volumio[1092]: info: Discovery: Getting this device information Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:06 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:06 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:06 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 14:34:06 volumio-603 volumio[1092]: info: Received Get System Info Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 14:34:06 volumio-603 volumio[1092]: info: Discovery: Getting this device information Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:06 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:06 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:06 volumio-603 volumio[1092]: info: Listing playlists Nov 01 14:34:06 volumio-603 volumio[1092]: info: Received Get System Info Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 14:34:06 volumio-603 volumio[1092]: info: Discovery: Getting this device information Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:06 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:34:06 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:06 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 14:34:09 volumio-603 volumio[1092]: info: Retrieving Cloud Streaming UI Nov 01 14:34:09 volumio-603 volumio[1092]: info: Getting Tidal Cloud Configuration Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 14:34:09 volumio-603 volumio[1092]: info: Getting Qobuz Cloud Configuration Nov 01 14:34:09 volumio-603 volumio[1092]: info: Asking plugin for UI Config Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 14:34:09 volumio-603 volumio[1092]: info: Getting Spotify Cloud Configuration Nov 01 14:34:09 volumio-603 volumio[1092]: info: Asking plugin for UI Config Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 14:34:09 volumio-603 volumio[1092]: info: Saving Spotify Acccount Nov 01 14:34:09 volumio-603 volumio[1092]: info: Got Tidal Cloud Configuration Nov 01 14:34:09 volumio-603 volumio[1092]: info: Got it Nov 01 14:34:09 volumio-603 volumio[1092]: info: Got it Nov 01 14:34:09 volumio-603 volumio[1092]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 14:34:09 volumio-603 volumio[1092]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 14:34:09 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 01 14:34:10 volumio-603 volumio[1092]: info: MyVolumio login type: Token Nov 01 14:34:13 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 14:34:13 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 14:34:14 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetQueue Nov 01 14:34:14 volumio-603 volumio[1092]: info: CoreStateMachine::getQueue Nov 01 14:34:14 volumio-603 volumio[1092]: info: CorePlayQueue::getQueue Nov 01 14:34:15 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 14:34:15 volumio-603 volumio[1092]: info: CURURI: music-library Nov 01 14:34:15 volumio-603 volumio[1092]: info: Preload queue cleared Nov 01 14:34:16 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 14:34:17 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 14:34:17 volumio-603 volumio[1092]: info: CURURI: music-library/INTERNAL Nov 01 14:34:17 volumio-603 volumio[1092]: info: Preload queue cleared Nov 01 14:34:19 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 14:34:19 volumio-603 volumio[1092]: info: CURURI: music-library/NAS Nov 01 14:34:19 volumio-603 volumio[1092]: info: Preload queue cleared Nov 01 14:34:22 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 14:34:22 volumio-603 volumio[1092]: info: CURURI: music-library/NAS/DSD Nov 01 14:34:22 volumio-603 volumio[1092]: info: Preload queue cleared Nov 01 14:34:28 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioplayNextItems Nov 01 14:34:28 volumio-603 volumio[1092]: info: CoreStateMachine::playNextItems Nov 01 14:34:28 volumio-603 volumio[1092]: info: CorePlayQueue::addPlayNextItems Nov 01 14:34:28 volumio-603 volumio[1092]: info: Preload queue cleared Nov 01 14:34:28 volumio-603 volumio[1092]: info: Adding Item to play next: music-library/NAS/DSD Nov 01 14:34:28 volumio-603 volumio[1092]: info: Using cached record of: music-library/NAS/DSD Nov 01 14:34:28 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushQueue Nov 01 14:34:28 volumio-603 volumio[1092]: info: CorePlayQueue::saveQueue Nov 01 14:34:28 volumio-603 volumio[1092]: info: CoreStateMachine::updateTrackBlock Nov 01 14:34:28 volumio-603 volumio[1092]: info: CorePlayQueue::getTrackBlock Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioNext Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::next Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::stPlaybackTimer Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::updateTrackBlock Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrackBlock Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::serviceStop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 14 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::serviceStop Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::stop Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand stop took 18 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::play index undefined Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::startPlaybackTimer Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::clearAddPlayTracks NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf Nov 01 14:34:30 volumio-603 volumio[1092]: info: Setting Volume to 100 automatically for DSD Nov 01 14:34:30 volumio-603 volumio[1092]: info: VolumeController::SetAlsaVolume100 Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::updateTrackBlock Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrackBlock Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 66 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand stop took 34 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 30 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand clear took 30 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 23 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 15 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand add "NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf" Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: 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":"NAS/纯音乐/洞箫 - 03 分骨肉.ape","trackType":"ape"} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: No code Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: 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} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: No code Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: 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} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: No code Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 220ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 152ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 149ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:30 volumio-603 volumio[1092]: error: updateQueue error: null Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 151ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand add "NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf" took 144 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 19ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 16ms Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand play Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 46ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand play took 42 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 41ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 39ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 18 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: Nov 01 14:34:30 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 29 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 28 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 26 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 19 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 15 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"转一圈","artist":"蔡幸娟","album":"妈妈情歌 转一圈","uri":"NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf","trackType":"dsf"} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus stop Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 58ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand status took 25 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 18 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"转一圈","artist":"蔡幸娟","album":"妈妈情歌 转一圈","uri":"NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf","trackType":"dsf"} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:30 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"转一圈","artist":"蔡幸娟","album":"妈妈情歌 转一圈","uri":"NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf","trackType":"dsf"} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:30 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"转一圈","artist":"蔡幸娟","album":"妈妈情歌 转一圈","uri":"NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf","trackType":"dsf"} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:30 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5,"duration":217,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"转一圈","artist":"蔡幸娟","album":"妈妈情歌 转一圈","uri":"NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf","trackType":"dsf"} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:30 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 173ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 171ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 158ms Nov 01 14:34:30 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 130 milliseconds Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":217,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"转一圈","artist":"蔡幸娟","album":"妈妈情歌 转一圈","uri":"NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf","trackType":"dsf"} Nov 01 14:34:30 volumio-603 volumio[1092]: verbose: CURRENT POSITION 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:30 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:30 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:30 volumio-603 volumio[1092]: info: ------------------------------ 202ms Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioNext Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::next Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::stop Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::stPlaybackTimer Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::updateTrackBlock Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrackBlock Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::serviceStop Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 15 Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::serviceStop Nov 01 14:34:39 volumio-603 volumio[1092]: info: ControllerMpd::stop Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 14:34:39 volumio-603 volumio[1092]: info: Nov 01 14:34:39 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand stop took 29 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::play index undefined Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::startPlaybackTimer Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::clearAddPlayTracks NAS/DSD/01 -dsd64- 小城故事.dff Nov 01 14:34:39 volumio-603 volumio[1092]: info: Setting Volume to 100 automatically for DSD Nov 01 14:34:39 volumio-603 volumio[1092]: info: VolumeController::SetAlsaVolume100 Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::updateTrackBlock Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrackBlock Nov 01 14:34:39 volumio-603 volumio[1092]: info: Nov 01 14:34:39 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:39 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:39 volumio-603 volumio[1092]: info: Nov 01 14:34:39 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:39 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand status took 69 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand stop took 33 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand status took 8 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand status took 5 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:39 volumio-603 volumio[1092]: info: Nov 01 14:34:39 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:39 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:39 volumio-603 volumio[1092]: info: Nov 01 14:34:39 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:39 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:39 volumio-603 volumio[1092]: error: updateQueue error: null Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand clear took 16 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 16 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 15 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: ------------------------------ 8ms Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand add "NAS/DSD/01 -dsd64- 小城故事.dff" Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:39 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:39 volumio-603 volumio[1092]: 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":"NAS/DSD/01 - 蔡幸娟 - 转一圈.dsf","trackType":"dsf"} Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: CURRENT POSITION 16 Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService stop Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus stop Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: No code Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:39 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:39 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:39 volumio-603 volumio[1092]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 01 14:34:39 volumio-603 volumio[1092]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 01 14:34:39 volumio-603 volumio[1092]: info: ------------------------------ 147ms Nov 01 14:34:39 volumio-603 volumio[1092]: info: ------------------------------ 83ms Nov 01 14:34:39 volumio-603 volumio[1092]: info: ------------------------------ 81ms Nov 01 14:34:39 volumio-603 volumio[1092]: info: Nov 01 14:34:39 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:39 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:39 volumio-603 volumio[1092]: info: Nov 01 14:34:39 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:39 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:39 volumio-603 volumio[1092]: error: updateQueue error: null Nov 01 14:34:39 volumio-603 volumio[1092]: info: Nov 01 14:34:39 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:39 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:39 volumio-603 volumio[1092]: info: ------------------------------ 83ms Nov 01 14:34:39 volumio-603 volumio[1092]: info: sendMpdCommand add "NAS/DSD/01 -dsd64- 小城故事.dff" took 78 milliseconds Nov 01 14:34:39 volumio-603 volumio[1092]: info: ------------------------------ 25ms Nov 01 14:34:39 volumio-603 volumio[1092]: info: ------------------------------ 18ms Nov 01 14:34:39 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand play Nov 01 14:34:40 volumio-603 volumio[1092]: info: Nov 01 14:34:40 volumio-603 volumio[1092]: ---------------------------- MPD announces system playlist update Nov 01 14:34:40 volumio-603 volumio[1092]: info: Ignoring MPD Status Update Nov 01 14:34:40 volumio-603 volumio[1092]: info: ------------------------------ 32ms Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand play took 17 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: info: ------------------------------ 13ms Nov 01 14:34:40 volumio-603 volumio[1092]: info: Nov 01 14:34:40 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:40 volumio-603 volumio[1092]: info: Nov 01 14:34:40 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:40 volumio-603 volumio[1092]: info: Nov 01 14:34:40 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:40 volumio-603 volumio[1092]: info: Nov 01 14:34:40 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand status took 18 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand status took 15 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:40 volumio-603 volumio[1092]: info: Nov 01 14:34:40 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:40 volumio-603 volumio[1092]: info: Nov 01 14:34:40 volumio-603 volumio[1092]: ---------------------------- MPD announces state update: player Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::getState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand status Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand status took 19 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand status took 10 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":160,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 -dsd64- 小城故事.dff","artist":null,"album":null,"uri":"NAS/DSD/01 -dsd64- 小城故事.dff","trackType":"dff"} Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: CURRENT POSITION 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus stop Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":160,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 -dsd64- 小城故事.dff","artist":null,"album":null,"uri":"NAS/DSD/01 -dsd64- 小城故事.dff","trackType":"dff"} Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: CURRENT POSITION 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:40 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: ------------------------------ 66ms Nov 01 14:34:40 volumio-603 volumio[1092]: info: ------------------------------ 70ms Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand status took 50 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand status took 49 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 45 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseState Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":160,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 -dsd64- 小城故事.dff","artist":null,"album":null,"uri":"NAS/DSD/01 -dsd64- 小城故事.dff","trackType":"dff"} Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: CURRENT POSITION 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:40 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":160,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 -dsd64- 小城故事.dff","artist":null,"album":null,"uri":"NAS/DSD/01 -dsd64- 小城故事.dff","trackType":"dff"} Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: CURRENT POSITION 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:40 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: ------------------------------ 122ms Nov 01 14:34:40 volumio-603 volumio[1092]: info: ------------------------------ 115ms Nov 01 14:34:40 volumio-603 volumio[1092]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 01 14:34:40 volumio-603 volumio[1092]: info: Retrying Login Due to Network Error Nov 01 14:34:40 volumio-603 volumio[1092]: info: sendMpdCommand playlistinfo took 66 milliseconds Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: ControllerMpd::parseTrackInfo Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":160,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 -dsd64- 小城故事.dff","artist":null,"album":null,"uri":"NAS/DSD/01 -dsd64- 小城故事.dff","trackType":"dff"} Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: CURRENT POSITION 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:40 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: ControllerMpd::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::servicePushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":160,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"01 -dsd64- 小城故事.dff","artist":null,"album":null,"uri":"NAS/DSD/01 -dsd64- 小城故事.dff","trackType":"dff"} Nov 01 14:34:40 volumio-603 volumio[1092]: verbose: CURRENT POSITION 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState stateService play Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::syncState currentStatus play Nov 01 14:34:40 volumio-603 volumio[1092]: info: Received an update from plugin. extracting info from payload Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreStateMachine::pushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:34:40 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioPushState Nov 01 14:34:40 volumio-603 volumio[1092]: info: ------------------------------ 191ms Nov 01 14:34:40 volumio-603 volumio[1092]: info: ------------------------------ 189ms Nov 01 14:34:50 volumio-603 volumio[1092]: info: MyVolumio login type: Token Nov 01 14:34:52 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 14:34:52 volumio-603 volumio[1092]: info: CURURI: music-library/NAS/DSD512 Nov 01 14:34:52 volumio-603 volumio[1092]: info: Preload queue cleared Nov 01 14:35:01 volumio-603 volumiologrotate[701]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Nov 01 14:35:01 volumio-603 volumiologrotate[701]: ls: cannot access '603': No such file or directory Nov 01 14:35:20 volumio-603 volumio[1092]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 01 14:35:20 volumio-603 volumio[1092]: info: Retrying Login Due to Network Error Nov 01 14:35:30 volumio-603 volumio[1092]: info: MyVolumio login type: Token Nov 01 14:35:44 volumio-603 sudo[5157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 14:35:44 volumio-603 sudo[5157]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 14:35:44 volumio-603 sudo[5161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 14:35:44 volumio-603 sudo[5161]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 14:35:44 volumio-603 sudo[5157]: pam_unix(sudo:session): session closed for user root Nov 01 14:35:44 volumio-603 sudo[5161]: pam_unix(sudo:session): session closed for user root Nov 01 14:35:44 volumio-603 volumio[1092]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.10 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) FxiOS/131.4 Mobile/15E148 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 11 Nov 01 14:35:44 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 14:35:45 volumio-603 sudo[5165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 14:35:45 volumio-603 sudo[5165]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 01 14:35:45 volumio-603 sudo[5167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 14:35:45 volumio-603 sudo[5167]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 14:35:45 volumio-603 sudo[5167]: pam_unix(sudo:session): session closed for user root Nov 01 14:35:45 volumio-603 sudo[5165]: pam_unix(sudo:session): session closed for user root Nov 01 14:35:45 volumio-603 volumio[1092]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.10 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) FxiOS/131.4 Mobile/15E148 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 12 Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:35:45 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetQueue Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreStateMachine::getQueue Nov 01 14:35:45 volumio-603 volumio[1092]: info: CorePlayQueue::getQueue Nov 01 14:35:45 volumio-603 volumio[1092]: info: Listing playlists Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 14:35:45 volumio-603 volumio[1092]: info: Received Get System Info Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 14:35:45 volumio-603 volumio[1092]: info: Discovery: Getting this device information Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:35:45 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:35:45 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 14:35:45 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 01 14:35:46 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 01 14:35:47 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 14:35:47 volumio-603 volumio[1092]: info: Received Get System Info Nov 01 14:35:47 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 14:35:47 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 14:35:47 volumio-603 volumio[1092]: info: Discovery: Getting this device information Nov 01 14:35:47 volumio-603 volumio[1092]: info: CoreCommandRouter::volumioGetState Nov 01 14:35:47 volumio-603 volumio[1092]: info: CorePlayQueue::getTrack 16 Nov 01 14:35:47 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 14:35:55 volumio-603 volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 14:35:55 volumio-603 volumio[1092]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E4%BA%91%E6%9C%B5/%E7%BC%98%E5%AE%9A%E4%BB%8A%E7%94%9F/5358a265-fa88-4c8c-b31c-35eeaaebb201.jpg' Nov 01 14:35:56 volumio-603 volumio[1092]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 14:35:56 volumio-603 volumio[1092]: Error: connect ECONNREFUSED 98.159.108.61:443 Nov 01 14:35:56 volumio-603 volumio[1092]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Nov 01 14:35:56 volumio-603 volumio[1092]: errno: -111, Nov 01 14:35:56 volumio-603 volumio[1092]: code: 'ECONNREFUSED', Nov 01 14:35:56 volumio-603 volumio[1092]: syscall: 'connect', Nov 01 14:35:56 volumio-603 volumio[1092]: address: '98.159.108.61', Nov 01 14:35:56 volumio-603 volumio[1092]: port: 443 Nov 01 14:35:56 volumio-603 volumio[1092]: } Nov 01 14:35:56 volumio-603 volumio[1092]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 14:35:57 volumio-603 sudo[5182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-01 14:34 Nov 01 14:35:57 volumio-603 sudo[5182]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"