-- Logs begin at Sat 2024-07-06 15:57:46 MDT, end at Fri 2024-07-12 10:43:10 MDT. -- Jul 12 10:42:00 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetState Jul 12 10:42:00 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:01 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 12 10:42:01 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 12 10:42:01 volumio01 volumio[862]: info: Received Get System Info Jul 12 10:42:01 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 10:42:01 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 10:42:01 volumio01 volumio[862]: info: Discovery: Getting this device information Jul 12 10:42:01 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetState Jul 12 10:42:01 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:01 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:02 volumio01 volumio[862]: info: Retrieving Cloud Streaming UI Jul 12 10:42:02 volumio01 volumio[862]: info: Getting Tidal Cloud Configuration Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:02 volumio01 volumio[862]: info: Getting Qobuz Cloud Configuration Jul 12 10:42:02 volumio01 volumio[862]: info: Asking plugin for UI Config Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:02 volumio01 volumio[862]: info: Getting Spotify Cloud Configuration Jul 12 10:42:02 volumio01 volumio[862]: info: Asking plugin for UI Config Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:02 volumio01 volumio[862]: info: Saving Spotify Acccount Jul 12 10:42:02 volumio01 volumio[862]: info: Got Tidal Cloud Configuration Jul 12 10:42:02 volumio01 volumio[862]: info: Got it Jul 12 10:42:02 volumio01 volumio[862]: info: Got it Jul 12 10:42:02 volumio01 volumio[862]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:02 volumio01 volumio[862]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:42:02 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 12 10:42:03 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 12 10:42:03 volumio01 volumio[862]: info: Received Get System Info Jul 12 10:42:03 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 10:42:03 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 10:42:03 volumio01 volumio[862]: info: Discovery: Getting this device information Jul 12 10:42:03 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetState Jul 12 10:42:03 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:03 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 10:42:06 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:42:09 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 12 10:42:10 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetState Jul 12 10:42:10 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:12 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:12 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 12 10:42:12 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 12 10:42:12 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 12 10:42:12 volumio01 volumio[862]: info: Received Get System Version Jul 12 10:42:12 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 12 10:42:18 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 12 10:42:18 volumio01 volumio[862]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 12 10:42:18 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 12 10:42:18 volumio01 volumio[862]: info: Received Get System Version Jul 12 10:42:18 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 12 10:42:18 volumio01 volumio[862]: info: Received Get System Info Jul 12 10:42:18 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 10:42:18 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 10:42:18 volumio01 volumio[862]: info: Discovery: Getting this device information Jul 12 10:42:18 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetState Jul 12 10:42:18 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:18 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 10:42:24 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetState Jul 12 10:42:24 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:31 volumio01 volumio[862]: info: Retrieving Cloud Streaming UI Jul 12 10:42:31 volumio01 volumio[862]: info: Getting Tidal Cloud Configuration Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:31 volumio01 volumio[862]: info: Getting Qobuz Cloud Configuration Jul 12 10:42:31 volumio01 volumio[862]: info: Asking plugin for UI Config Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:31 volumio01 volumio[862]: info: Getting Spotify Cloud Configuration Jul 12 10:42:31 volumio01 volumio[862]: info: Asking plugin for UI Config Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:31 volumio01 volumio[862]: info: Saving Spotify Acccount Jul 12 10:42:31 volumio01 volumio[862]: info: Got Tidal Cloud Configuration Jul 12 10:42:31 volumio01 volumio[862]: info: Got it Jul 12 10:42:31 volumio01 volumio[862]: info: Got it Jul 12 10:42:31 volumio01 volumio[862]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:31 volumio01 volumio[862]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:42:31 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 12 10:42:33 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand update Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:33 volumio01 volumio[862]: info: Jul 12 10:42:33 volumio01 volumio[862]: ---------------------------- MPD announces state update: update Jul 12 10:42:33 volumio01 volumio[862]: info: sendMpdCommand update took 7 milliseconds Jul 12 10:42:33 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:33 volumio01 volumio[862]: info: Jul 12 10:42:33 volumio01 volumio[862]: ---------------------------- MPD announces state update: update Jul 12 10:42:33 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:33 volumio01 volumio[862]: info: Jul 12 10:42:33 volumio01 volumio[862]: ---------------------------- MPD announces state update: update Jul 12 10:42:33 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:33 volumio01 volumio[862]: info: sendMpdCommand status took 27 milliseconds Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:33 volumio01 volumio[862]: info: Command Router : Notfying DB Updatetrue Jul 12 10:42:33 volumio01 volumio[862]: info: sendMpdCommand status took 81 milliseconds Jul 12 10:42:33 volumio01 volumio[862]: info: sendMpdCommand status took 80 milliseconds Jul 12 10:42:33 volumio01 volumio[862]: info: sendMpdCommand status took 79 milliseconds Jul 12 10:42:33 volumio01 volumio[862]: info: sendMpdCommand status took 78 milliseconds Jul 12 10:42:33 volumio01 volumio[862]: info: sendMpdCommand status took 77 milliseconds Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:33 volumio01 volumio[862]: info: Command Router : Notfying DB Updatetrue Jul 12 10:42:33 volumio01 volumio[862]: info: CoreCommandRouter::Close All Modals sent Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:33 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:34 volumio01 volumio[862]: info: Command Router : Notfying DB Updatetrue Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::Close All Modals sent Jul 12 10:42:34 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:34 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: 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} Jul 12 10:42:34 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService stop Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus stop Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: No code Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: 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} Jul 12 10:42:34 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService stop Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus stop Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: No code Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: 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} Jul 12 10:42:34 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService stop Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus stop Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: No code Jul 12 10:42:34 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:34 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:34 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:34 volumio01 volumio[862]: info: ------------------------------ 219ms Jul 12 10:42:34 volumio01 volumio[862]: info: ------------------------------ 217ms Jul 12 10:42:34 volumio01 volumio[862]: info: ------------------------------ 216ms Jul 12 10:42:35 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:42:37 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jul 12 10:42:37 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand update Jul 12 10:42:37 volumio01 volumio[862]: info: sendMpdCommand update took 2 milliseconds Jul 12 10:42:38 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jul 12 10:42:38 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand rescan Jul 12 10:42:38 volumio01 volumio[862]: info: sendMpdCommand rescan took 2 milliseconds Jul 12 10:42:39 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:42:43 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:42:47 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:42:49 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetState Jul 12 10:42:49 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPlay Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::play index undefined Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::startPlaybackTimer Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3 Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand stop Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand stop took 1 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand clear Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand clear took 1 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3" Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces system playlist update Jul 12 10:42:50 volumio01 volumio[862]: info: Ignoring MPD Status Update Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces system playlist update Jul 12 10:42:50 volumio01 volumio[862]: info: Ignoring MPD Status Update Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand add "NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3" took 5 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand play Jul 12 10:42:50 volumio01 volumio[862]: Upnp client error: Error: This socket has been ended by the other party Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces system playlist update Jul 12 10:42:50 volumio01 volumio[862]: info: Ignoring MPD Status Update Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces system playlist update Jul 12 10:42:50 volumio01 volumio[862]: info: Ignoring MPD Status Update Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 19ms Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 18ms Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand play took 14 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 11ms Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 8ms Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces system playlist update Jul 12 10:42:50 volumio01 volumio[862]: info: Ignoring MPD Status Update Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces system playlist update Jul 12 10:42:50 volumio01 volumio[862]: info: Ignoring MPD Status Update Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 4ms Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 3ms Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:50 volumio01 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand status took 36 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand status took 34 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand status took 32 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:50 volumio01 volumio[862]: info: Jul 12 10:42:50 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand status took 21 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 15 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand status took 11 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand status took 8 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:50 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService play Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus stop Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:50 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService play Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus play Jul 12 10:42:50 volumio01 volumio[862]: info: Received an update from plugin. extracting info from payload Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:50 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService play Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus play Jul 12 10:42:50 volumio01 volumio[862]: info: Received an update from plugin. extracting info from payload Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 116ms Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 116ms Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 112ms Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 53 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 47 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 46 milliseconds Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:50 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:50 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService play Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus play Jul 12 10:42:50 volumio01 volumio[862]: info: Received an update from plugin. extracting info from payload Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:50 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService play Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus play Jul 12 10:42:50 volumio01 volumio[862]: info: Received an update from plugin. extracting info from payload Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:50 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService play Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus play Jul 12 10:42:50 volumio01 volumio[862]: info: Received an update from plugin. extracting info from payload Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:50 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:50 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 137ms Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 123ms Jul 12 10:42:50 volumio01 volumio[862]: info: ------------------------------ 121ms Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::volumioPause Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::pause Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::stPlaybackTimer Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::servicePause Jul 12 10:42:56 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::servicePause Jul 12 10:42:56 volumio01 volumio[862]: info: ControllerMpd::pause Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand pause Jul 12 10:42:56 volumio01 volumio[862]: info: Jul 12 10:42:56 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:56 volumio01 volumio[862]: info: sendMpdCommand pause took 3 milliseconds Jul 12 10:42:56 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:56 volumio01 volumio[862]: info: Jul 12 10:42:56 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:56 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:56 volumio01 volumio[862]: info: Jul 12 10:42:56 volumio01 volumio[862]: ---------------------------- MPD announces state update: player Jul 12 10:42:56 volumio01 volumio[862]: info: ControllerMpd::getState Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand status Jul 12 10:42:56 volumio01 volumio[862]: info: sendMpdCommand status took 8 milliseconds Jul 12 10:42:56 volumio01 volumio[862]: info: sendMpdCommand status took 6 milliseconds Jul 12 10:42:56 volumio01 volumio[862]: info: sendMpdCommand status took 3 milliseconds Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::parseState Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 12 10:42:56 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 12 10:42:56 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 12 10:42:56 volumio01 volumio[862]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:56 volumio01 volumio[862]: verbose: ControllerMpd::parseTrackInfo Jul 12 10:42:56 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:56 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:56 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6582,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:56 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService pause Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus pause Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:56 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::stPlaybackTimer Jul 12 10:42:56 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:56 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:56 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6582,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:56 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService pause Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus pause Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:56 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::stPlaybackTimer Jul 12 10:42:56 volumio01 volumio[862]: info: ControllerMpd::pushState Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::servicePushState Jul 12 10:42:56 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:56 volumio01 volumio[862]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6582,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dancing Queen","artist":"ABBA","album":"Gold","uri":"NAS/NAS01.1/ABBA/Gold/01 Dancing Queen.mp3","trackType":"mp3"} Jul 12 10:42:56 volumio01 volumio[862]: verbose: CURRENT POSITION 0 Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::syncState stateService pause Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::syncState currentStatus pause Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::pushState Jul 12 10:42:56 volumio01 volumio[862]: info: CorePlayQueue::getTrack 0 Jul 12 10:42:56 volumio01 volumio[862]: info: CoreCommandRouter::volumioPushState Jul 12 10:42:56 volumio01 volumio[862]: info: CoreStateMachine::stPlaybackTimer Jul 12 10:42:56 volumio01 volumio[862]: info: ------------------------------ 51ms Jul 12 10:42:56 volumio01 volumio[862]: info: ------------------------------ 49ms Jul 12 10:42:56 volumio01 volumio[862]: info: ------------------------------ 47ms Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:59 volumio01 volumio[862]: info: Retrieving Cloud Streaming UI Jul 12 10:42:59 volumio01 volumio[862]: info: Getting Tidal Cloud Configuration Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:59 volumio01 volumio[862]: info: Getting Qobuz Cloud Configuration Jul 12 10:42:59 volumio01 volumio[862]: info: Asking plugin for UI Config Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:59 volumio01 volumio[862]: info: Getting Spotify Cloud Configuration Jul 12 10:42:59 volumio01 volumio[862]: info: Asking plugin for UI Config Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:59 volumio01 volumio[862]: info: Saving Spotify Acccount Jul 12 10:42:59 volumio01 volumio[862]: info: Got Tidal Cloud Configuration Jul 12 10:42:59 volumio01 volumio[862]: info: Got it Jul 12 10:42:59 volumio01 volumio[862]: info: Got it Jul 12 10:42:59 volumio01 volumio[862]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 12 10:42:59 volumio01 volumio[862]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::volumioGetBrowseSources Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:42:59 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 12 10:43:03 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:43:04 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 12 10:43:04 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 12 10:43:07 volumio01 volumio[862]: info: Error browsing device macdt11 (3) for shares : Error: Command failed: echo volumio | smbclient -L macdt11.local. Jul 12 10:43:07 volumio01 volumio[862]: Unable to initialize messaging context Jul 12 10:43:07 volumio01 volumio[862]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 12 10:43:10 volumio01 volumio[862]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 12 10:43:10 volumio01 volumio[862]: Error: dns service error: unknown Jul 12 10:43:10 volumio01 volumio[862]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jul 12 10:43:10 volumio01 volumio[862]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jul 12 10:43:10 volumio01 volumio[862]: errorCode: -65537 Jul 12 10:43:10 volumio01 volumio[862]: } Jul 12 10:43:10 volumio01 volumio[862]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 12 10:43:10 volumio01 sudo[25524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-12 10:42 Jul 12 10:43:10 volumio01 sudo[25524]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"