-- Logs begin at Sun 2024-12-01 15:28:30 CST, end at Sun 2024-12-01 15:35:58 CST. -- Dec 01 15:34:00 volumio-z8300 volumio[2662]: STREAMING PROXY: Starting server on port 3245 Dec 01 15:34:00 volumio-z8300 volumio[2662]: Node JS runtime: 14 Dec 01 15:34:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 01 15:34:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 15:34:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 01 15:34:13 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 01 15:34:13 volumio-z8300 volumio[2662]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Dec 01 15:34:13 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetState Dec 01 15:34:13 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:18 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 15:34:18 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 15:34:18 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 01 15:34:18 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 01 15:34:18 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 01 15:34:18 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetBrowseSources Dec 01 15:34:18 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 01 15:34:19 volumio-z8300 volumio[2662]: error: MyVolumio Plugin failed to authenticate in a timely fashion Dec 01 15:34:19 volumio-z8300 volumio[2662]: info: Completed starting MyVolumio Plugin Dec 01 15:34:19 volumio-z8300 volumio[2662]: [Metrics] CommandRouter: 106s 993.08ms Dec 01 15:34:19 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumiosetStartupVolume Dec 01 15:34:19 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 15:34:19 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 15:34:19 volumio-z8300 volumio[2662]: info: CoreCommandRouter::Close All Modals sent Dec 01 15:34:19 volumio-z8300 volumio[2662]: info: CoreCommandRouter::Close All Modals sent Dec 01 15:34:20 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 01 15:34:20 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 01 15:34:21 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 01 15:34:26 volumio-z8300 volumio[2662]: info: BOOT COMPLETED Dec 01 15:34:29 volumio-z8300 volumio[2662]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Dec 01 15:34:29 volumio-z8300 volumio[2662]: info: Retrying Login Due to Network Error Dec 01 15:34:39 volumio-z8300 volumio[2662]: info: MyVolumio login type: Token Dec 01 15:34:57 volumio-z8300 volumio[2662]: verbose: New Socket.io Connection to 192.168.50.100 from 192.168.50.199 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/130.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetVisibleSources Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetState Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Retrieving Cloud Streaming UI Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Received Get System Info Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Discovery: Getting this device information Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetState Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetState Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Listing playlists Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Getting Tidal Cloud Configuration Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Getting Qobuz Cloud Configuration Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Asking plugin for UI Config Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Getting Spotify Cloud Configuration Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Asking plugin for UI Config Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Saving Spotify Acccount Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Got Tidal Cloud Configuration Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Got it Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: Got it Dec 01 15:34:57 volumio-z8300 volumio[2662]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:34:57 volumio-z8300 volumio[2662]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetBrowseSources Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetBrowseSources Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetBrowseSources Dec 01 15:34:57 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 15:34:58 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: Received Get System Info Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: Discovery: Getting this device information Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand rescan Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: Dec 01 15:34:59 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: update Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: sendMpdCommand rescan took 5 milliseconds Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: Dec 01 15:34:59 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: update Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: Dec 01 15:34:59 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: update Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 12 milliseconds Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 9 milliseconds Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 7 milliseconds Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 7 milliseconds Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 6 milliseconds Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 4 milliseconds Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: Command Router : Notfying DB Updatetrue Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: Command Router : Notfying DB Updatetrue Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::Close All Modals sent Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: Command Router : Notfying DB Updatetrue Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::Close All Modals sent Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: No code Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: No code Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 01 15:34:59 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: No code Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ------------------------------ 201ms Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ------------------------------ 196ms Dec 01 15:34:59 volumio-z8300 volumio[2662]: info: ------------------------------ 196ms Dec 01 15:35:01 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 01 15:35:01 volumio-z8300 volumio-remote-updater[789]: No test mode Dec 01 15:35:01 volumio-z8300 volumio-remote-updater[789]: No alpha test mode Dec 01 15:35:01 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 01 15:35:02 volumio-z8300 volumio[2662]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 01 15:35:02 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 01 15:35:02 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetState Dec 01 15:35:02 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:07 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 01 15:35:09 volumio-z8300 volumio[2662]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Dec 01 15:35:09 volumio-z8300 volumio[2662]: info: Retrying Login Due to Network Error Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: MPD Database updated - AlbumList cache refreshed Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Dec 01 15:35:11 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: database Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Dec 01 15:35:11 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: update Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: MPD Database updated - AlbumList cache refreshed Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Dec 01 15:35:11 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: database Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Dec 01 15:35:11 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: update Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: MPD Database updated - AlbumList cache refreshed Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Dec 01 15:35:11 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: database Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Dec 01 15:35:11 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: update Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 56 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 54 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 53 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 47 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 46 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 44 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 39 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 37 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 35 milliseconds Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Command Router : Notfying DB Updatefalse Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::Close All Modals sent Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Command Router : Notfying DB Updatefalse Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::Close All Modals sent Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: Command Router : Notfying DB Updatefalse Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::Close All Modals sent Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: 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} Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: No code Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: 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} Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: No code Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: 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} Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: No code Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: 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} Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: No code Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: 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} Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: No code Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: 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} Dec 01 15:35:11 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: No code Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ------------------------------ 350ms Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ------------------------------ 350ms Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ------------------------------ 343ms Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ------------------------------ 342ms Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ------------------------------ 334ms Dec 01 15:35:11 volumio-z8300 volumio[2662]: info: ------------------------------ 334ms Dec 01 15:35:19 volumio-z8300 volumio[2662]: info: MyVolumio login type: Token Dec 01 15:35:20 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetQueue Dec 01 15:35:20 volumio-z8300 volumio[2662]: info: CoreStateMachine::getQueue Dec 01 15:35:20 volumio-z8300 volumio[2662]: info: CorePlayQueue::getQueue Dec 01 15:35:22 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetState Dec 01 15:35:22 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Retrieving Cloud Streaming UI Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Getting Tidal Cloud Configuration Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Getting Qobuz Cloud Configuration Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Asking plugin for UI Config Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Getting Spotify Cloud Configuration Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Asking plugin for UI Config Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Saving Spotify Acccount Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Got Tidal Cloud Configuration Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Got it Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: Got it Dec 01 15:35:24 volumio-z8300 volumio[2662]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 15:35:24 volumio-z8300 volumio[2662]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetBrowseSources Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetBrowseSources Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetBrowseSources Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 15:35:24 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 01 15:35:28 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 15:35:31 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioGetState Dec 01 15:35:31 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 0 Dec 01 15:35:32 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 01 15:35:32 volumio-z8300 volumio[2662]: info: CURURI: music-library Dec 01 15:35:33 volumio-z8300 volumio[2662]: info: Preload queue cleared Dec 01 15:35:33 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 01 15:35:33 volumio-z8300 volumio[2662]: info: CURURI: music-library/NAS Dec 01 15:35:33 volumio-z8300 volumio[2662]: info: Preload queue cleared Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: CURURI: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE] Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preload queue cleared Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/万芳 - 猜心.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李丽芬 - 爱江山更爱美人.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李度 - 舍不得把眼睛睁开.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李碧华 - 分手.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/林忆莲 - 伤痕.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/潘越云 - 痴痴地等.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/裘海正 - 爱我的人和我爱的人.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/辛晓琪 - 味道.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈明真 - 我用自己的方式爱你.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈淑桦 - 梦醒时分.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/黄莺莺 - 哭砂.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 - 橄榄树.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Preloading song: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 潘越云 - 梦田.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/万芳 - 猜心.wav in service mpd Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E4%B8%87%E8%8A%B3%20-%20%E7%8C%9C%E5%BF%83.wav&metadata=false Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/万芳 - 猜心.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav in service mpd Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E5%BC%A0%E8%89%BE%E5%98%89%20-%20%E7%88%B1%E7%9A%84%E4%BB%A3%E4%BB%B7.wav&metadata=false Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav in service mpd Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E5%BE%90%E6%80%80%E9%92%B0%20-%20%E5%88%86%E9%A3%9E.wav&metadata=false Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李丽芬 - 爱江山更爱美人.wav in service mpd Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E6%9D%8E%E4%B8%BD%E8%8A%AC%20-%20%E7%88%B1%E6%B1%9F%E5%B1%B1%E6%9B%B4%E7%88%B1%E7%BE%8E%E4%BA%BA.wav&metadata=false Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李丽芬 - 爱江山更爱美人.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李度 - 舍不得把眼睛睁开.wav in service mpd Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E6%9D%8E%E5%BA%A6%20-%20%E8%88%8D%E4%B8%8D%E5%BE%97%E6%8A%8A%E7%9C%BC%E7%9D%9B%E7%9D%81%E5%BC%80.wav&metadata=false Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李度 - 舍不得把眼睛睁开.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李碧华 - 分手.wav in service mpd Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E6%9D%8E%E7%A2%A7%E5%8D%8E%20-%20%E5%88%86%E6%89%8B.wav&metadata=false Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李碧华 - 分手.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/林忆莲 - 伤痕.wav in service mpd Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E6%9E%97%E5%BF%86%E8%8E%B2%20-%20%E4%BC%A4%E7%97%95.wav&metadata=false Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/林忆莲 - 伤痕.wav Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/潘越云 - 痴痴地等.wav in service mpd Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E6%BD%98%E8%B6%8A%E4%BA%91%20-%20%E7%97%B4%E7%97%B4%E5%9C%B0%E7%AD%89.wav&metadata=false Dec 01 15:35:37 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/潘越云 - 痴痴地等.wav Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/裘海正 - 爱我的人和我爱的人.wav in service mpd Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E8%A3%98%E6%B5%B7%E6%AD%A3%20-%20%E7%88%B1%E6%88%91%E7%9A%84%E4%BA%BA%E5%92%8C%E6%88%91%E7%88%B1%E7%9A%84%E4%BA%BA.wav&metadata=false Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/裘海正 - 爱我的人和我爱的人.wav Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/辛晓琪 - 味道.wav in service mpd Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E8%BE%9B%E6%99%93%E7%90%AA%20-%20%E5%91%B3%E9%81%93.wav&metadata=false Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/辛晓琪 - 味道.wav Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈明真 - 我用自己的方式爱你.wav in service mpd Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E9%99%88%E6%98%8E%E7%9C%9F%20-%20%E6%88%91%E7%94%A8%E8%87%AA%E5%B7%B1%E7%9A%84%E6%96%B9%E5%BC%8F%E7%88%B1%E4%BD%A0.wav&metadata=false Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈明真 - 我用自己的方式爱你.wav Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈淑桦 - 梦醒时分.wav in service mpd Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E9%99%88%E6%B7%91%E6%A1%A6%20-%20%E6%A2%A6%E9%86%92%E6%97%B6%E5%88%86.wav&metadata=false Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈淑桦 - 梦醒时分.wav Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/黄莺莺 - 哭砂.wav in service mpd Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E9%BB%84%E8%8E%BA%E8%8E%BA%20-%20%E5%93%AD%E7%A0%82.wav&metadata=false Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/黄莺莺 - 哭砂.wav Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 - 橄榄树.wav in service mpd Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E9%BD%90%E8%B1%AB%20-%20%E6%A9%84%E6%A6%84%E6%A0%91.wav&metadata=false Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 - 橄榄树.wav Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: Exploding uri music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 潘越云 - 梦田.wav in service mpd Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: ALBUMART /albumart?cacheid=563&web=//extralarge&path=%2Fmnt%2FNAS%2F%E6%A8%A1%E6%8B%9F%E4%B9%8B%E5%A3%B0%E6%85%A2%E5%88%BBCD%E3%80%8A%E6%BB%9A%E7%9F%B3%E7%95%99%E5%A3%B0.%E6%83%85%E7%89%B5%E5%A5%B3%E4%BA%BA%E5%BF%83%E3%80%8B%E5%8E%9F%E5%A3%B0%E6%AF%8D%E5%B8%A6%5B%E4%BD%8E%E9%80%9F%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2F%E9%BD%90%E8%B1%AB%20%E6%BD%98%E8%B6%8A%E4%BA%91%20-%20%E6%A2%A6%E7%94%B0.wav&metadata=false Dec 01 15:35:38 volumio-z8300 volumio[2662]: info: URI /mnt/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 潘越云 - 梦田.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Preload queue cleared Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::ClearQueue Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::stop Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::clearPlayQueue Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::saveQueue Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushQueue Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::addQueueItems Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::addQueueItems Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Preload queue cleared Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/万芳 - 猜心.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/万芳 - 猜心.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushQueue Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::saveQueue Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::updateTrackBlock Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrackBlock Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPlay Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::play index 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::addQueueItems Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::addQueueItems Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Preload queue cleared Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李丽芬 - 爱江山更爱美人.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李丽芬 - 爱江山更爱美人.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李度 - 舍不得把眼睛睁开.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李度 - 舍不得把眼睛睁开.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李碧华 - 分手.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/李碧华 - 分手.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/林忆莲 - 伤痕.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/林忆莲 - 伤痕.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/潘越云 - 痴痴地等.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/潘越云 - 痴痴地等.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/裘海正 - 爱我的人和我爱的人.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/裘海正 - 爱我的人和我爱的人.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/辛晓琪 - 味道.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/辛晓琪 - 味道.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈明真 - 我用自己的方式爱你.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈明真 - 我用自己的方式爱你.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈淑桦 - 梦醒时分.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/陈淑桦 - 梦醒时分.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/黄莺莺 - 哭砂.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/黄莺莺 - 哭砂.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 - 橄榄树.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 - 橄榄树.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Adding Item to queue: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 潘越云 - 梦田.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Using cached record of: music-library/NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/齐豫 潘越云 - 梦田.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::stop Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushQueue Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::saveQueue Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::play index undefined Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::updateTrackBlock Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrackBlock Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::startPlaybackTimer Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::clearAddPlayTracks NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand stop Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand stop took 10 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand clear Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand clear took 4 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand add "NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav" Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:39 volumio-z8300 volumio[2662]: error: updateQueue error: null Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 10ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand add "NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav" took 9 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 7ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 7ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 11ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand play took 6 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 6ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 5ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 8 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 5 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Dec 01 15:35:39 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 12 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 10 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 7 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 5 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 49ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 58ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 38 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 37 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 33 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 34 milliseconds Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:39 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 123ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 122ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 118ms Dec 01 15:35:39 volumio-z8300 volumio[2662]: info: ------------------------------ 116ms Dec 01 15:35:47 volumio-z8300 rc.local[951]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 01 15:35:47 volumio-z8300 rc.local[951]: Dload Upload Total Spent Left Speed Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: Dec 01 15:35:47 volumio-z8300 volumio[2662]: ---------------------------- Client requests Volumio toggle Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioToggle Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::stPlaybackTimer Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::servicePause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: ControllerMpd::pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: Dec 01 15:35:47 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: sendMpdCommand pause took 4 milliseconds Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:47 volumio-z8300 rc.local[951]: [237B blob data] Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: Dec 01 15:35:47 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: Dec 01 15:35:47 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 8 milliseconds Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 9 milliseconds Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 7 milliseconds Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9334,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::stPlaybackTimer Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: ------------------------------ 33ms Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9334,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::stPlaybackTimer Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9334,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:47 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus pause Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:47 volumio-z8300 volumio[2662]: info: CoreStateMachine::stPlaybackTimer Dec 01 15:35:48 volumio-z8300 volumio[2662]: info: ------------------------------ 51ms Dec 01 15:35:48 volumio-z8300 volumio[2662]: info: ------------------------------ 50ms Dec 01 15:35:49 volumio-z8300 volumio[2662]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Dec 01 15:35:49 volumio-z8300 volumio[2662]: info: Retrying Login Due to Network Error Dec 01 15:35:49 volumio-z8300 rc.local[951]: {"time":1733038547930,"response":"toggle Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 01 15:35:49 volumio-z8300 rc.local[951]: Dload Upload Total Spent Left Speed Dec 01 15:35:49 volumio-z8300 volumio[2662]: info: Dec 01 15:35:49 volumio-z8300 volumio[2662]: ---------------------------- Client requests Volumio toggle Dec 01 15:35:49 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioToggle Dec 01 15:35:49 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:49 volumio-z8300 volumio[2662]: info: CoreStateMachine::play index undefined Dec 01 15:35:49 volumio-z8300 volumio[2662]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::startPlaybackTimer Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ControllerMpd::resume Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand play Dec 01 15:35:50 volumio-z8300 rc.local[951]: [158B blob data] Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: Dec 01 15:35:50 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: sendMpdCommand play took 6 milliseconds Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: Dec 01 15:35:50 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: Dec 01 15:35:50 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 7 milliseconds Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 5 milliseconds Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 7 milliseconds Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10199,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus pause Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10199,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ------------------------------ 57ms Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ------------------------------ 55ms Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 43 milliseconds Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10199,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:50 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:50 volumio-z8300 volumio[2662]: info: ------------------------------ 79ms Dec 01 15:35:52 volumio-z8300 rc.local[951]: {"time":1733038549996,"response":"toggle Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 01 15:35:52 volumio-z8300 rc.local[951]: Dload Upload Total Spent Left Speed Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- Client requests Volumio next Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioNext Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::next Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::stop Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::stPlaybackTimer Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::updateTrackBlock Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrackBlock Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::serviceStop Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 1 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::serviceStop Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::stop Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand stop Dec 01 15:35:52 volumio-z8300 rc.local[951]: [158B blob data] Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand stop took 25 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::play index undefined Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::startPlaybackTimer Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::clearAddPlayTracks NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand stop Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::updateTrackBlock Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrackBlock Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 14 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand stop took 10 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 6 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 4 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand clear Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand clear took 7 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand add "NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav" Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: 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":"张艾嘉 - 爱的代价.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/张艾嘉 - 爱的代价.wav","trackType":"wav"} Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService stop Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: No code Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 01 15:35:52 volumio-z8300 volumio[2662]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 65ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 56ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 53ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:52 volumio-z8300 volumio[2662]: error: updateQueue error: null Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 46ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand add "NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav" took 42 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 5ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 3ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces system playlist update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Ignoring MPD Status Update Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 13ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand play took 12 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 11ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 8ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 5 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 4 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 3 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Dec 01 15:35:52 volumio-z8300 volumio[2662]: ---------------------------- MPD announces state update: player Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::getState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand status Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 6 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand status took 3 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseState Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐怀钰 - 分飞.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav","trackType":"wav"} Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus stop Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐怀钰 - 分飞.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav","trackType":"wav"} Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐怀钰 - 分飞.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav","trackType":"wav"} Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 40ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 67ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 66ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 56 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: sendMpdCommand playlistinfo took 55 milliseconds Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: ControllerMpd::parseTrackInfo Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐怀钰 - 分飞.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav","trackType":"wav"} Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ControllerMpd::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::servicePushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"徐怀钰 - 分飞.wav","artist":null,"album":null,"uri":"NAS/模拟之声慢刻CD《滚石留声.情牵女人心》原声母带[低速原抓WAV+CUE]/徐怀钰 - 分飞.wav","trackType":"wav"} Dec 01 15:35:52 volumio-z8300 volumio[2662]: verbose: CURRENT POSITION 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState stateService play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::syncState currentStatus play Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: Received an update from plugin. extracting info from payload Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreStateMachine::pushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CorePlayQueue::getTrack 2 Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: CoreCommandRouter::volumioPushState Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 98ms Dec 01 15:35:52 volumio-z8300 volumio[2662]: info: ------------------------------ 94ms Dec 01 15:35:57 volumio-z8300 volumio[2662]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 15:35:57 volumio-z8300 volumio[2662]: Error: connect ETIMEDOUT 69.171.224.36:443 Dec 01 15:35:57 volumio-z8300 volumio[2662]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 01 15:35:57 volumio-z8300 volumio[2662]: errno: -110, Dec 01 15:35:57 volumio-z8300 volumio[2662]: code: 'ETIMEDOUT', Dec 01 15:35:57 volumio-z8300 volumio[2662]: syscall: 'connect', Dec 01 15:35:57 volumio-z8300 volumio[2662]: address: '69.171.224.36', Dec 01 15:35:57 volumio-z8300 volumio[2662]: port: 443 Dec 01 15:35:57 volumio-z8300 volumio[2662]: } Dec 01 15:35:57 volumio-z8300 volumio[2662]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 15:35:58 volumio-z8300 sudo[3492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 15:34 Dec 01 15:35:58 volumio-z8300 sudo[3492]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"