-- Logs begin at Thu 2019-02-14 16:11:59 +06, end at Wed 2025-02-19 17:08:34 +06. -- Feb 19 17:07:00 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:00 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:00 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:02 volumio volumio[929]: info: VolumeController::SetAlsaVolume49 Feb 19 17:07:02 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:02 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:02 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:02 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:02 volumio volumio[929]: info: Listing playlists Feb 19 17:07:02 volumio volumio[929]: info: Listing playlists Feb 19 17:07:02 volumio volumio[929]: info: VolumeController::SetAlsaVolume41 Feb 19 17:07:02 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:02 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:02 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:03 volumio volumio[929]: info: VolumeController::SetAlsaVolume39 Feb 19 17:07:03 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:03 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:03 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:03 volumio volumio[929]: info: VolumeController::SetAlsaVolume31 Feb 19 17:07:03 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:03 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:03 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:05 volumio volumio[929]: info: VolumeController::SetAlsaVolume28 Feb 19 17:07:05 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:05 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:05 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:05 volumio volumio[929]: info: VolumeController::SetAlsaVolume25 Feb 19 17:07:05 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:05 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:05 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:11 volumio volumio[1905]: [Vollibrespot] : Fetching autoplay context uri Feb 19 17:07:11 volumio volumio[1905]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 189581110837364150211937906509552881642, audio_type: Track }, track_id: SpotifyId { id: 279109899692879639235940442039007114772, audio_type: Track } } Feb 19 17:07:12 volumio volumio[1905]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:37i9dQZF1EVHGWrwldPRtj"> Feb 19 17:07:12 volumio volumio[1905]: [Vollibrespot] : Resolving uri "spotify:station:playlist:37i9dQZF1EVHGWrwldPRtj" Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:12 volumio volumio[1905]: [Vollibrespot] : Loading with Spotify URI Feb 19 17:07:12 volumio volumio[1905]: [Vollibrespot] : Resolved 50 tracks from <"spotify:playlist:37i9dQZF1EVHGWrwldPRtj"> Feb 19 17:07:12 volumio volumio[1905]: [Vollibrespot] : Event: SinkInactive Feb 19 17:07:12 volumio volumio[1905]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 279109899692879639235940442039007114772, audio_type: Track } } Feb 19 17:07:12 volumio volumio[929]: [SpotifyConnect] La La La Feb 19 17:07:12 volumio volumio[929]: [SpotifyConnect] Pushing metadata Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:12 volumio volumio[929]: [SpotifyConnect] Currently active: volspotconnect2 Feb 19 17:07:12 volumio volumio[929]: [SpotifyConnect] Pushing new state :: true Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::servicePushState Feb 19 17:07:12 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:12 volumio volumio[929]: [SpotifyConnect] Sink released Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::servicePushState Feb 19 17:07:12 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:12 volumio volumio[1905]: [Vollibrespot] : (210224 ms) loaded Feb 19 17:07:12 volumio volumio[1905]: [Vollibrespot] : Event: SinkActive Feb 19 17:07:12 volumio volumio[929]: [SpotifyConnect] Sink acquired Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:12 volumio volumio[929]: [SpotifyConnect] Currently active: volspotconnect2 Feb 19 17:07:12 volumio volumio[929]: [SpotifyConnect] Pushing new state :: true Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::servicePushState Feb 19 17:07:12 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:12 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:18 volumio volumio[1905]: [Vollibrespot] : Fetching autoplay context uri Feb 19 17:07:18 volumio volumio[1905]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 279109899692879639235940442039007114772, audio_type: Track }, track_id: SpotifyId { id: 199070292195425542895808260748263110406, audio_type: Track } } Feb 19 17:07:18 volumio volumio[1905]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:37i9dQZF1EVHGWrwldPRtj"> Feb 19 17:07:18 volumio volumio[1905]: [Vollibrespot] : Resolving uri "spotify:station:playlist:37i9dQZF1EVHGWrwldPRtj" Feb 19 17:07:19 volumio volumio[1905]: [Vollibrespot] : Resolved 50 tracks from <"spotify:playlist:37i9dQZF1EVHGWrwldPRtj"> Feb 19 17:07:19 volumio volumio[1905]: [Vollibrespot] : Loading with Spotify URI Feb 19 17:07:19 volumio volumio[1905]: [Vollibrespot] : Event: SinkInactive Feb 19 17:07:19 volumio volumio[1905]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 199070292195425542895808260748263110406, audio_type: Track } } Feb 19 17:07:19 volumio volumio[929]: [SpotifyConnect] Broken Angel Feb 19 17:07:19 volumio volumio[929]: [SpotifyConnect] Pushing metadata Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:19 volumio volumio[929]: [SpotifyConnect] Currently active: volspotconnect2 Feb 19 17:07:19 volumio volumio[929]: [SpotifyConnect] Pushing new state :: true Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::servicePushState Feb 19 17:07:19 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:19 volumio volumio[1905]: [Vollibrespot] : (202657 ms) loaded Feb 19 17:07:19 volumio volumio[1905]: [Vollibrespot] : Event: SinkActive Feb 19 17:07:19 volumio volumio[929]: [SpotifyConnect] Sink released Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::servicePushState Feb 19 17:07:19 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:19 volumio volumio[929]: [SpotifyConnect] Sink acquired Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:19 volumio volumio[929]: [SpotifyConnect] Currently active: volspotconnect2 Feb 19 17:07:19 volumio volumio[929]: [SpotifyConnect] Pushing new state :: true Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::servicePushState Feb 19 17:07:19 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:19 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:22 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:22 volumio volumio[929]: info: Listing playlists Feb 19 17:07:22 volumio volumio[929]: info: Listing playlists Feb 19 17:07:30 volumio volumio[1905]: [Vollibrespot] : Event: Pause { track_id: SpotifyId { id: 199070292195425542895808260748263110406, audio_type: Track }, position_ms: 10755 } Feb 19 17:07:30 volumio volumio[929]: [SpotifyConnect] pause Feb 19 17:07:32 volumio volumio[1905]: [Vollibrespot] : Event: SinkInactive Feb 19 17:07:32 volumio volumio[1905]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 199070292195425542895808260748263110406, audio_type: Track } } Feb 19 17:07:32 volumio volumio[929]: [SpotifyConnect] Broken Angel Feb 19 17:07:32 volumio volumio[929]: [SpotifyConnect] Pushing metadata Feb 19 17:07:32 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:32 volumio volumio[929]: [SpotifyConnect] Currently active: volspotconnect2 Feb 19 17:07:32 volumio volumio[929]: [SpotifyConnect] Pushing new state :: true Feb 19 17:07:32 volumio volumio[929]: info: CoreCommandRouter::servicePushState Feb 19 17:07:32 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:32 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:32 volumio volumio[929]: [SpotifyConnect] Sink released Feb 19 17:07:32 volumio volumio[929]: info: CoreCommandRouter::servicePushState Feb 19 17:07:32 volumio volumio[929]: info: CoreStateMachine::pushState Feb 19 17:07:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 19 17:07:32 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Feb 19 17:07:32 volumio volumio[929]: [SpotifyConnect] Device palyback is inactive Feb 19 17:07:32 volumio volumio[929]: [SpotifyConnect] Device is paused Feb 19 17:07:32 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:42 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:07:42 volumio volumio[929]: info: Listing playlists Feb 19 17:07:42 volumio volumio[929]: info: Listing playlists Feb 19 17:07:52 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:08:02 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:08:02 volumio volumio[929]: info: Listing playlists Feb 19 17:08:02 volumio volumio[929]: info: Listing playlists Feb 19 17:08:12 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:08:22 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:08:22 volumio volumio[929]: info: Listing playlists Feb 19 17:08:22 volumio volumio[929]: info: Listing playlists Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 19 17:08:26 volumio volumio[929]: info: Retrieving Cloud Streaming UI Feb 19 17:08:26 volumio volumio[929]: info: Getting Tidal Cloud Configuration Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 19 17:08:26 volumio volumio[929]: info: Getting Qobuz Cloud Configuration Feb 19 17:08:26 volumio volumio[929]: info: Asking plugin for UI Config Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 19 17:08:26 volumio volumio[929]: info: Getting Spotify Cloud Configuration Feb 19 17:08:26 volumio volumio[929]: info: Asking plugin for UI Config Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 19 17:08:26 volumio volumio[929]: info: Saving Spotify Acccount Feb 19 17:08:26 volumio volumio[929]: info: Got Tidal Cloud Configuration Feb 19 17:08:26 volumio volumio[929]: info: Got it Feb 19 17:08:26 volumio volumio[929]: info: Got it Feb 19 17:08:26 volumio volumio[929]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 19 17:08:26 volumio volumio[929]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 19 17:08:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 19 17:08:29 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 19 17:08:29 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 19 17:08:30 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 19 17:08:30 volumio volumio[929]: info: Error browsing device My_NAS for shares : Error: Command failed: echo volumio | smbclient -L My_NAS.local. Feb 19 17:08:30 volumio volumio[929]: Unable to initialize messaging context Feb 19 17:08:32 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Feb 19 17:08:34 volumio volumio[929]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 19 17:08:34 volumio volumio[929]: Error: dns service error: unknown Feb 19 17:08:34 volumio volumio[929]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Feb 19 17:08:34 volumio volumio[929]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Feb 19 17:08:34 volumio volumio[929]: errorCode: -65537 Feb 19 17:08:34 volumio volumio[929]: } Feb 19 17:08:34 volumio volumio[929]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 19 17:08:34 volumio sudo[2355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-19 17:07 Feb 19 17:08:34 volumio sudo[2355]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"