-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-05-12 21:34:26 CEST. -- May 12 21:33:26 volumio kernel: hwmon hwmon1: Undervoltage detected! May 12 21:33:30 volumio kernel: hwmon hwmon1: Voltage normalised May 12 21:33:33 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 21:33:33 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 21:33:33 volumio volumio[809]: info: Discovery: Getting this device information May 12 21:33:33 volumio volumio[809]: info: CoreCommandRouter::volumioGetState May 12 21:33:33 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:33:33 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 21:33:33 volumio volumio[809]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.212 UA: unknown Total Clients: 4 May 12 21:33:33 volumio volumio[809]: info: CoreCommandRouter::volumioGetState May 12 21:33:33 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:33:33 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 12 21:33:33 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 12 21:33:35 volumio sudo[4425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 12 21:33:35 volumio sudo[4425]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 21:33:35 volumio sudo[4425]: pam_unix(sudo:session): session closed for user root May 12 21:33:35 volumio sudo[4428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 12 21:33:35 volumio sudo[4428]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 21:33:35 volumio sudo[4428]: pam_unix(sudo:session): session closed for user root May 12 21:33:35 volumio volumio[809]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.212 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::volumioGetVisibleSources May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::volumioGetState May 12 21:33:35 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 12 21:33:35 volumio volumio[809]: info: Received Get System Info May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 21:33:35 volumio volumio[809]: info: Discovery: Getting this device information May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::volumioGetState May 12 21:33:35 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::volumioGetState May 12 21:33:35 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:33:35 volumio volumio[809]: info: Listing playlists May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 12 21:33:35 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 12 21:33:36 volumio kernel: hwmon hwmon1: Undervoltage detected! May 12 21:33:37 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 21:33:37 volumio volumio[809]: info: Received Get System Info May 12 21:33:37 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 21:33:37 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 21:33:37 volumio volumio[809]: info: Discovery: Getting this device information May 12 21:33:37 volumio volumio[809]: info: CoreCommandRouter::volumioGetState May 12 21:33:37 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:33:37 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 21:33:37 volumio volumio[809]: info: CoreCommandRouter::volumioGetQueue May 12 21:33:37 volumio volumio[809]: info: CoreStateMachine::getQueue May 12 21:33:37 volumio volumio[809]: info: CorePlayQueue::getQueue May 12 21:33:38 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 21:33:38 volumio volumio[809]: info: Received Get System Info May 12 21:33:38 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 21:33:38 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 21:33:38 volumio volumio[809]: info: Discovery: Getting this device information May 12 21:33:38 volumio volumio[809]: info: CoreCommandRouter::volumioGetState May 12 21:33:38 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:33:38 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 21:33:40 volumio kernel: hwmon hwmon1: Voltage normalised May 12 21:33:40 volumio nmbd[628]: [2024/05/12 21:33:40.957090, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 12 21:33:40 volumio nmbd[628]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.115 for name WORKGROUP<1d>. May 12 21:33:40 volumio nmbd[628]: This response was from IP 192.168.1.15, reporting an IP address of 192.168.1.15. May 12 21:33:42 volumio kernel: hwmon hwmon1: Undervoltage detected! May 12 21:33:47 volumio kernel: hwmon hwmon1: Voltage normalised May 12 21:33:48 volumio volumio[809]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 21:33:48 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 12 21:33:49 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 12 21:33:49 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 12 21:33:49 volumio kernel: hwmon hwmon1: Undervoltage detected! May 12 21:33:49 volumio volumio[809]: info: Received Get System Version May 12 21:33:49 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 21:33:53 volumio volumio-remote-updater[529]: No test mode May 12 21:33:53 volumio volumio-remote-updater[529]: No alpha test mode May 12 21:33:53 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 12 21:33:53 volumio volumio[809]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 12 21:33:53 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 12 21:33:53 volumio volumio[809]: info: Received Get System Version May 12 21:33:53 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 21:33:53 volumio volumio[809]: info: Received Get System Info May 12 21:33:53 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 21:33:53 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 21:33:53 volumio volumio[809]: info: Discovery: Getting this device information May 12 21:33:53 volumio volumio[809]: info: CoreCommandRouter::volumioGetState May 12 21:33:53 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:33:53 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 21:33:54 volumio volumio[809]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 12 21:33:54 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 12 21:33:56 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:03 volumio kernel: hwmon hwmon1: Voltage normalised May 12 21:34:05 volumio kernel: hwmon hwmon1: Undervoltage detected! May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 21:34:09 volumio volumio[809]: info: Retrieving Cloud Streaming UI May 12 21:34:09 volumio volumio[809]: info: Getting Tidal Cloud Configuration May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 21:34:09 volumio volumio[809]: info: Getting Qobuz Cloud Configuration May 12 21:34:09 volumio volumio[809]: info: Asking plugin for UI Config May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 21:34:09 volumio volumio[809]: info: Getting Spotify Cloud Configuration May 12 21:34:09 volumio volumio[809]: info: Asking plugin for UI Config May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 21:34:09 volumio volumio[809]: info: Saving Spotify Acccount May 12 21:34:09 volumio volumio[809]: info: Got Tidal Cloud Configuration May 12 21:34:09 volumio volumio[809]: info: Got it May 12 21:34:09 volumio volumio[809]: info: Got it May 12 21:34:09 volumio volumio[809]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 21:34:09 volumio volumio[809]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::volumioGetBrowseSources May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::volumioGetBrowseSources May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::volumioGetBrowseSources May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 12 21:34:09 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 12 21:34:13 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 12 21:34:15 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 12 21:34:15 volumio sudo[4455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Musica May 12 21:34:15 volumio sudo[4455]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 21:34:15 volumio systemd[1]: mnt-NAS-Musica.mount: Succeeded. May 12 21:34:16 volumio sudo[4455]: pam_unix(sudo:session): session closed for user root May 12 21:34:16 volumio volumio[809]: info: Share Musica successfully unmounted May 12 21:34:17 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 12 21:34:17 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 12 21:34:18 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:18 volumio volumio[809]: info: May 12 21:34:18 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:18 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:18 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:18 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:18 volumio volumio[809]: info: May 12 21:34:18 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:18 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:18 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:18 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:18 volumio volumio[809]: info: May 12 21:34:18 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:18 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:18 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:18 volumio volumio[809]: info: [1715542458783] Database update started May 12 21:34:19 volumio volumio[809]: info: MPD Database updated - AlbumList cache refreshed May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces state update: database May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces system playlist update May 12 21:34:19 volumio volumio[809]: info: Ignoring MPD Status Update May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 435 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 432 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 431 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 428 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 427 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 425 milliseconds May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 628ms May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 624ms May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 620ms May 12 21:34:19 volumio volumio[809]: error: updateQueue error: null May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 281 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 280 milliseconds May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 284ms May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 279 milliseconds May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 344ms May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 343ms May 12 21:34:19 volumio volumio[809]: info: MPD Database updated - AlbumList cache refreshed May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces state update: database May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces system playlist update May 12 21:34:19 volumio volumio[809]: info: Ignoring MPD Status Update May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: info: MPD Database updated - AlbumList cache refreshed May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces state update: database May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces system playlist update May 12 21:34:19 volumio volumio[809]: info: Ignoring MPD Status Update May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: info: May 12 21:34:19 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:19 volumio volumio[809]: error: updateQueue error: null May 12 21:34:19 volumio volumio[809]: error: updateQueue error: null May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 27 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 26 milliseconds May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 28ms May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 26 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 24 milliseconds May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 23 milliseconds May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 26ms May 12 21:34:19 volumio volumio[809]: info: sendMpdCommand status took 23 milliseconds May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:19 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: No code May 12 21:34:19 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:19 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:19 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 142ms May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 141ms May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 139ms May 12 21:34:19 volumio volumio[809]: info: ------------------------------ 139ms May 12 21:34:19 volumio volumio[809]: error: Upnp client error: Error: This socket has been ended by the other party May 12 21:34:21 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand update May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: info: May 12 21:34:22 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand update took 5 milliseconds May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: info: May 12 21:34:22 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: info: May 12 21:34:22 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: info: May 12 21:34:22 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 16 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 14 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 13 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 11 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 11 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 8 milliseconds May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:22 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: No code May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:22 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: No code May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:22 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: No code May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: ------------------------------ 242ms May 12 21:34:22 volumio volumio[809]: info: ------------------------------ 239ms May 12 21:34:22 volumio volumio[809]: info: ------------------------------ 237ms May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: info: May 12 21:34:22 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: info: May 12 21:34:22 volumio volumio[809]: ---------------------------- MPD announces state update: update May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::getState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::sendMpdCommand status May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 247 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 245 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 12 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 11 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 9 milliseconds May 12 21:34:22 volumio volumio[809]: info: sendMpdCommand status took 8 milliseconds May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: info: Command Router : Notfying DB Updatefalse May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::Close All Modals sent May 12 21:34:22 volumio volumio[809]: verbose: ControllerMpd::parseState May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:22 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: No code May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:22 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:22 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:22 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:23 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:23 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:23 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:23 volumio volumio[809]: info: No code May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:23 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:23 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:23 volumio volumio[809]: info: ControllerMpd::pushState May 12 21:34:23 volumio volumio[809]: info: CoreCommandRouter::servicePushState May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:23 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:23 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:23 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:23 volumio volumio[809]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 21:34:23 volumio volumio[809]: verbose: CURRENT POSITION 0 May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::syncState stateService stop May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::syncState currentStatus stop May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:23 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:23 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:23 volumio volumio[809]: info: No code May 12 21:34:23 volumio volumio[809]: info: CoreStateMachine::pushState May 12 21:34:23 volumio volumio[809]: info: CorePlayQueue::getTrack 0 May 12 21:34:23 volumio volumio[809]: info: CoreCommandRouter::volumioPushState May 12 21:34:23 volumio volumio[809]: info: ------------------------------ 474ms May 12 21:34:23 volumio volumio[809]: info: ------------------------------ 240ms May 12 21:34:23 volumio volumio[809]: info: ------------------------------ 238ms May 12 21:34:24 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 12 21:34:24 volumio volumio[809]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 12 21:34:25 volumio volumio[809]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 21:34:25 volumio volumio[809]: Error: getaddrinfo -3007 May 12 21:34:25 volumio volumio[809]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) May 12 21:34:25 volumio volumio[809]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) May 12 21:34:25 volumio volumio[809]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { May 12 21:34:25 volumio volumio[809]: code: -3007, May 12 21:34:25 volumio volumio[809]: errno: -3007, May 12 21:34:25 volumio volumio[809]: syscall: 'getaddrinfo' May 12 21:34:25 volumio volumio[809]: } May 12 21:34:25 volumio volumio[809]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 21:34:26 volumio sudo[4541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 21:33 May 12 21:34:26 volumio sudo[4541]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"