-- 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"