-- Logs begin at Tue 2024-07-16 17:49:18 MSK, end at Tue 2024-07-16 17:51:21 MSK. --
Jul 16 17:50:26 volumio-2 ntpd[1037]: Soliciting pool server 192.36.143.130
Jul 16 17:50:26 volumio-2 ntpd[1037]: Soliciting pool server 188.134.81.45
Jul 16 17:50:27 volumio-2 ntpd[1037]: Soliciting pool server 91.206.16.3
Jul 16 17:50:27 volumio-2 ntpd[1037]: Soliciting pool server 195.3.218.2
Jul 16 17:50:27 volumio-2 ntpd[1037]: Soliciting pool server 195.3.254.2
Jul 16 17:50:28 volumio-2 ntpd[1037]: Soliciting pool server 95.31.7.160
Jul 16 17:50:28 volumio-2 ntpd[1037]: Soliciting pool server 162.159.200.123
Jul 16 17:50:28 volumio-2 ntpd[1037]: Soliciting pool server 185.209.85.222
Jul 16 17:50:28 volumio-2 ntpd[1037]: Soliciting pool server 195.218.227.230
Jul 16 17:50:29 volumio-2 ntpd[1037]: Soliciting pool server 85.21.78.91
Jul 16 17:50:29 volumio-2 ntpd[1037]: Soliciting pool server 91.207.136.55
Jul 16 17:50:29 volumio-2 ntpd[1037]: Soliciting pool server 195.211.77.68
Jul 16 17:50:30 volumio-2 ntpd[1037]: Soliciting pool server 2a00:1390:5:722b:1337:c0de:4:11fe
Jul 16 17:50:41 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPlay
Jul 16 17:50:41 volumio-2 volumio[1059]: info: CoreStateMachine::play index undefined
Jul 16 17:50:41 volumio-2 volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 16 17:50:41 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 0
Jul 16 17:50:41 volumio-2 volumio[1059]: info: CoreStateMachine::startPlaybackTimer
Jul 16 17:50:41 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 0
Jul 16 17:50:41 volumio-2 volumio[1059]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%9F%D0%BE%D0%BB%D1%91%D1%82%20%D0%BD%D0%B0%20%D0%B4%D0%B5%D0%BB%D1%8C%D1%82%D0%B0%D0%BF%D0%BB%D0%B0%D0%BD%D0%B5%22%2C%22artist%22%3A%22%D0%92%D0%B0%D0%BB%D0%B5%D1%80%D0%B8%D0%B9%20%D0%9B%D0%B5%D0%BE%D0%BD%D1%82%D1%8C%D0%B5%D0%B2%22%2C%22album%22%3A%22%D0%9C%D1%83%D0%B7%D0%B0%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2F_zEHd2g2Wt1C88xi0ktRgTMb0YZtqQEFyBO0GqhQB6DjI8SwmUH71Lo6xcCrN8EKatMCyxwJGiwwNZGQhQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22WkZ8KioW70E%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22WkZ8KioW70E%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Jul 16 17:50:41 volumio-2 volumio[1059]: info: [ytmusic] InnertubeLoader: creating Innertube instance...
Jul 16 17:50:42 volumio-2 volumio[1059]: info: [ytmusic] InnertubeLoader: creating Auth instance...
Jul 16 17:50:42 volumio-2 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 16 17:50:42 volumio-2 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 16 17:50:42 volumio-2 volumio[1059]: info: [ytmusic] InnertubeLoader: Auth instance created (status: pending sign-in)
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioNext
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CoreStateMachine::next
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CoreStateMachine::stop
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CoreStateMachine::play index undefined
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CoreStateMachine::startPlaybackTimer
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:49 volumio-2 volumio[1059]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%9Do%D1%87%D0%BDo%D0%B9%20%D0%B7%D0%B2o%D0%BDo%D0%BA%22%2C%22artist%22%3A%22%D0%92%D0%B0%D0%BB%D0%B5%D1%80%D0%B8%D0%B9%20%D0%9B%D0%B5%D0%BE%D0%BD%D1%82%D1%8C%D0%B5%D0%B2%22%2C%22album%22%3A%22%D0%9A%D0%BE%D0%BB%D0%BB%D0%B5%D0%BA%D1%86%D0%B8%D1%8F%20%D0%9B%D1%83%D1%87%D1%88%D0%B8%D1%85%20%D0%B0%D0%BB%D1%8C%D0%B1%D0%BE%D0%BC%D0%BE%D0%B2%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FwPxjBAnHKfOjCMsZX5UxK1x8MaQvN9WPWHWnIZ5wNOxysCQ3WmdB6OlHza4wnkywSe3syu97vnlIi5a1%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22jJTeQoXVX98%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22jJTeQoXVX98%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CoreStateMachine::updateTrackBlock
Jul 16 17:50:49 volumio-2 volumio[1059]: info: CorePlayQueue::getTrackBlock
Jul 16 17:50:52 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioRandom
Jul 16 17:50:52 volumio-2 volumio[1059]: info: CoreCommandRouter::writePlayerControls
Jul 16 17:50:52 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:52 volumio-2 volumio[1059]: info: CoreStateMachine::setRandom false
Jul 16 17:50:52 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:50:52 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:52 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 16 17:50:52 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:50:54 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPlay
Jul 16 17:50:54 volumio-2 volumio[1059]: info: CoreStateMachine::play index undefined
Jul 16 17:50:54 volumio-2 volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 16 17:50:54 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:54 volumio-2 volumio[1059]: info: CoreStateMachine::startPlaybackTimer
Jul 16 17:50:54 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:54 volumio-2 volumio[1059]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%9Do%D1%87%D0%BDo%D0%B9%20%D0%B7%D0%B2o%D0%BDo%D0%BA%22%2C%22artist%22%3A%22%D0%92%D0%B0%D0%BB%D0%B5%D1%80%D0%B8%D0%B9%20%D0%9B%D0%B5%D0%BE%D0%BD%D1%82%D1%8C%D0%B5%D0%B2%22%2C%22album%22%3A%22%D0%9A%D0%BE%D0%BB%D0%BB%D0%B5%D0%BA%D1%86%D0%B8%D1%8F%20%D0%9B%D1%83%D1%87%D1%88%D0%B8%D1%85%20%D0%B0%D0%BB%D1%8C%D0%B1%D0%BE%D0%BC%D0%BE%D0%B2%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FwPxjBAnHKfOjCMsZX5UxK1x8MaQvN9WPWHWnIZ5wNOxysCQ3WmdB6OlHza4wnkywSe3syu97vnlIi5a1%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22jJTeQoXVX98%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22jJTeQoXVX98%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Jul 16 17:50:56 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioRandom
Jul 16 17:50:56 volumio-2 volumio[1059]: info: CoreCommandRouter::writePlayerControls
Jul 16 17:50:56 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:56 volumio-2 volumio[1059]: info: CoreStateMachine::setRandom true
Jul 16 17:50:56 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:50:56 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:56 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 16 17:50:56 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:50:58 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioRandom
Jul 16 17:50:58 volumio-2 volumio[1059]: info: CoreCommandRouter::writePlayerControls
Jul 16 17:50:58 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:58 volumio-2 volumio[1059]: info: CoreStateMachine::setRandom false
Jul 16 17:50:58 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:50:58 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:58 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 16 17:50:58 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:50:59 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioRandom
Jul 16 17:50:59 volumio-2 volumio[1059]: info: CoreCommandRouter::writePlayerControls
Jul 16 17:50:59 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:59 volumio-2 volumio[1059]: info: CoreStateMachine::setRandom true
Jul 16 17:50:59 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:50:59 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:50:59 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 16 17:50:59 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:51:06 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPlay
Jul 16 17:51:06 volumio-2 volumio[1059]: info: CoreStateMachine::play index undefined
Jul 16 17:51:06 volumio-2 volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 16 17:51:06 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:06 volumio-2 volumio[1059]: info: CoreStateMachine::startPlaybackTimer
Jul 16 17:51:06 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:06 volumio-2 volumio[1059]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%9Do%D1%87%D0%BDo%D0%B9%20%D0%B7%D0%B2o%D0%BDo%D0%BA%22%2C%22artist%22%3A%22%D0%92%D0%B0%D0%BB%D0%B5%D1%80%D0%B8%D0%B9%20%D0%9B%D0%B5%D0%BE%D0%BD%D1%82%D1%8C%D0%B5%D0%B2%22%2C%22album%22%3A%22%D0%9A%D0%BE%D0%BB%D0%BB%D0%B5%D0%BA%D1%86%D0%B8%D1%8F%20%D0%9B%D1%83%D1%87%D1%88%D0%B8%D1%85%20%D0%B0%D0%BB%D1%8C%D0%B1%D0%BE%D0%BC%D0%BE%D0%B2%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FwPxjBAnHKfOjCMsZX5UxK1x8MaQvN9WPWHWnIZ5wNOxysCQ3WmdB6OlHza4wnkywSe3syu97vnlIi5a1%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22jJTeQoXVX98%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22jJTeQoXVX98%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Retrieving Cloud Streaming UI
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Getting Tidal Cloud Configuration
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Getting Qobuz Cloud Configuration
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Asking plugin for UI Config
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Getting Spotify Cloud Configuration
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Asking plugin for UI Config
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Saving Spotify Acccount
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Got Tidal Cloud Configuration
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Got it
Jul 16 17:51:17 volumio-2 volumio[1059]: info: Got it
Jul 16 17:51:17 volumio-2 volumio[1059]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 16 17:51:17 volumio-2 volumio[1059]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 16 17:51:17 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand update
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info:
Jul 16 17:51:19 volumio-2 volumio[1059]: ---------------------------- MPD announces state update: update
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand update took 2 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::getState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 1 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Command Router : Notfying DB Updatetrue
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::servicePushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ------------------------------ 27ms
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info:
Jul 16 17:51:19 volumio-2 volumio[1059]: ---------------------------- MPD announces state update: update
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::getState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info:
Jul 16 17:51:19 volumio-2 volumio[1059]: ---------------------------- MPD announces state update: update
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::getState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info:
Jul 16 17:51:19 volumio-2 volumio[1059]: ---------------------------- MPD announces state update: update
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::getState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 2 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 1 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Command Router : Notfying DB Updatefalse
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::Close All Modals sent
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Command Router : Notfying DB Updatefalse
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::Close All Modals sent
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::servicePushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::servicePushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ------------------------------ 30ms
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ------------------------------ 30ms
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info:
Jul 16 17:51:19 volumio-2 volumio[1059]: ---------------------------- MPD announces state update: update
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::getState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info:
Jul 16 17:51:19 volumio-2 volumio[1059]: ---------------------------- MPD announces state update: update
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::getState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::sendMpdCommand status
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 32 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 32 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 4 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 3 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: info: sendMpdCommand status took 2 milliseconds
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Command Router : Notfying DB Updatefalse
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::Close All Modals sent
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Command Router : Notfying DB Updatefalse
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::Close All Modals sent
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Command Router : Notfying DB Updatefalse
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::Close All Modals sent
Jul 16 17:51:19 volumio-2 volumio[1059]: verbose: ControllerMpd::parseState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::servicePushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::servicePushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ControllerMpd::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::servicePushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreStateMachine::pushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CoreCommandRouter::volumioPushState
Jul 16 17:51:19 volumio-2 volumio[1059]: info: CorePlayQueue::getTrack 2
Jul 16 17:51:19 volumio-2 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ------------------------------ 68ms
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ------------------------------ 39ms
Jul 16 17:51:19 volumio-2 volumio[1059]: info: ------------------------------ 38ms
Jul 16 17:51:21 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 16 17:51:21 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Jul 16 17:51:21 volumio-2 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Jul 16 17:51:21 volumio-2 volumio[1059]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 16 17:51:21 volumio-2 volumio[1059]: Error: getaddrinfo -3007
Jul 16 17:51:21 volumio-2 volumio[1059]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Jul 16 17:51:21 volumio-2 volumio[1059]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Jul 16 17:51:21 volumio-2 volumio[1059]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Jul 16 17:51:21 volumio-2 volumio[1059]: code: -3007,
Jul 16 17:51:21 volumio-2 volumio[1059]: errno: -3007,
Jul 16 17:51:21 volumio-2 volumio[1059]: syscall: 'getaddrinfo'
Jul 16 17:51:21 volumio-2 volumio[1059]: }
Jul 16 17:51:21 volumio-2 volumio[1059]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 16 17:51:21 volumio-2 sudo[1572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-16 17:50
Jul 16 17:51:21 volumio-2 sudo[1572]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"