-- Logs begin at Sat 2026-02-21 17:02:25 EET, end at Sun 2026-02-22 01:25:03 EET. -- Feb 22 01:24:02 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 22 01:24:28 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 01:24:28 primo volumio[3176]: info: CURURI: music-library Feb 22 01:24:28 primo volumio[3176]: info: Preload queue cleared Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::sendMpdCommand update Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::sendMpdCommand status Feb 22 01:24:36 primo volumio[3176]: info: Feb 22 01:24:36 primo volumio[3176]: ---------------------------- MPD announces state update: update Feb 22 01:24:36 primo volumio[3176]: info: sendMpdCommand update took 30 milliseconds Feb 22 01:24:36 primo volumio[3176]: info: ControllerMpd::getState Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::sendMpdCommand status Feb 22 01:24:36 primo volumio[3176]: info: sendMpdCommand status took 25 milliseconds Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::parseState Feb 22 01:24:36 primo volumio[3176]: info: Command Router : Notfying DB Updatetrue Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::Close All Modals sent Feb 22 01:24:36 primo volumio[3176]: info: sendMpdCommand status took 82 milliseconds Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::parseState Feb 22 01:24:36 primo volumio[3176]: info: ControllerMpd::pushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::servicePushState Feb 22 01:24:36 primo volumio[3176]: info: CoreStateMachine::pushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::volumioPushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::volumioGetState Feb 22 01:24:36 primo volumio[3176]: info: MRS: Pushing multiroomSync output update for this device Feb 22 01:24:36 primo volumio[3176]: info: MRS: Pushing multiroomSync output Feb 22 01:24:36 primo volumio[3176]: info: CorePlayQueue::getTrack 17 Feb 22 01:24:36 primo volumio[3176]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 01:24:36 primo volumio[3176]: verbose: CURRENT POSITION 17 Feb 22 01:24:36 primo volumio[3176]: info: CoreStateMachine::syncState stateService stop Feb 22 01:24:36 primo volumio[3176]: info: CoreStateMachine::syncState currentStatus pause Feb 22 01:24:36 primo volumio[3176]: info: CoreStateMachine::pushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::volumioPushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::volumioGetState Feb 22 01:24:36 primo volumio[3176]: info: MRS: Pushing multiroomSync output update for this device Feb 22 01:24:36 primo volumio[3176]: info: MRS: Pushing multiroomSync output Feb 22 01:24:36 primo volumio5-onboarding[4287]: time=2026-02-22T01:24:36.472+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.51:38558 @ 0x1eb80c0" state=STATUS_PAUSED positionMs=209930 volume=100 Feb 22 01:24:36 primo volumio5-onboarding[4287]: time=2026-02-22T01:24:36.473+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.51:38558 @ 0x1eb80c0" id=tidal://song/330933278 title=Panopticom Feb 22 01:24:36 primo volumio5-onboarding[4287]: time=2026-02-22T01:24:36.475+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.51:38558 @ 0x1eb80c0" state=STATUS_PAUSED positionMs=209930 volume=100 Feb 22 01:24:36 primo volumio5-onboarding[4287]: time=2026-02-22T01:24:36.475+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.51:38558 @ 0x1eb80c0" id=tidal://song/330933278 title=Panopticom Feb 22 01:24:36 primo volumio[3176]: info: ------------------------------ 144ms Feb 22 01:24:36 primo volumio[3176]: info: Updating RAAT Signal Path Feb 22 01:24:36 primo volumio[3176]: info: Updating RAAT Signal Path Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::sendMpdCommand status Feb 22 01:24:36 primo volumio[3176]: info: Feb 22 01:24:36 primo volumio[3176]: ---------------------------- MPD announces state update: update Feb 22 01:24:36 primo volumio[3176]: info: ControllerMpd::getState Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::sendMpdCommand status Feb 22 01:24:36 primo volumio[3176]: info: sendMpdCommand status took 5 milliseconds Feb 22 01:24:36 primo volumio[3176]: info: sendMpdCommand status took 3 milliseconds Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::parseState Feb 22 01:24:36 primo volumio[3176]: info: Command Router : Notfying DB Updatefalse Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::Close All Modals sent Feb 22 01:24:36 primo volumio[3176]: verbose: ControllerMpd::parseState Feb 22 01:24:36 primo volumio[3176]: info: ControllerMpd::pushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::servicePushState Feb 22 01:24:36 primo volumio[3176]: info: CoreStateMachine::pushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::volumioPushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::volumioGetState Feb 22 01:24:36 primo volumio[3176]: info: MRS: Pushing multiroomSync output update for this device Feb 22 01:24:36 primo volumio[3176]: info: MRS: Pushing multiroomSync output Feb 22 01:24:36 primo volumio[3176]: info: CorePlayQueue::getTrack 17 Feb 22 01:24:36 primo volumio[3176]: 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} Feb 22 01:24:36 primo volumio[3176]: verbose: CURRENT POSITION 17 Feb 22 01:24:36 primo volumio[3176]: info: CoreStateMachine::syncState stateService stop Feb 22 01:24:36 primo volumio[3176]: info: CoreStateMachine::syncState currentStatus pause Feb 22 01:24:36 primo volumio[3176]: info: CoreStateMachine::pushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::volumioPushState Feb 22 01:24:36 primo volumio[3176]: info: CoreCommandRouter::volumioGetState Feb 22 01:24:36 primo volumio[3176]: info: MRS: Pushing multiroomSync output update for this device Feb 22 01:24:36 primo volumio[3176]: info: MRS: Pushing multiroomSync output Feb 22 01:24:36 primo volumio5-onboarding[4287]: time=2026-02-22T01:24:36.871+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.51:38558 @ 0x1eb80c0" state=STATUS_PAUSED positionMs=209930 volume=100 Feb 22 01:24:36 primo volumio5-onboarding[4287]: time=2026-02-22T01:24:36.871+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.51:38558 @ 0x1eb80c0" id=tidal://song/330933278 title=Panopticom Feb 22 01:24:36 primo volumio5-onboarding[4287]: time=2026-02-22T01:24:36.875+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.51:38558 @ 0x1eb80c0" state=STATUS_PAUSED positionMs=209930 volume=100 Feb 22 01:24:36 primo volumio5-onboarding[4287]: time=2026-02-22T01:24:36.876+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.51:38558 @ 0x1eb80c0" id=tidal://song/330933278 title=Panopticom Feb 22 01:24:36 primo volumio[3176]: info: ------------------------------ 121ms Feb 22 01:24:36 primo volumio[3176]: info: Updating RAAT Signal Path Feb 22 01:24:36 primo volumio[3176]: info: Updating RAAT Signal Path Feb 22 01:24:38 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 01:24:38 primo volumio[3176]: info: CURURI: music-library/USB Feb 22 01:24:38 primo volumio[3176]: info: Preload queue cleared Feb 22 01:24:40 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 01:24:40 primo volumio[3176]: info: CURURI: music-library/USB/USB_DISK Feb 22 01:24:40 primo volumio[3176]: info: Preload queue cleared Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 01:24:52 primo volumio[3176]: info: Retrieving Cloud Streaming UI Feb 22 01:24:52 primo volumio[3176]: info: Getting Tidal Cloud Configuration Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 01:24:52 primo volumio[3176]: info: Getting Qobuz Cloud Configuration Feb 22 01:24:52 primo volumio[3176]: info: Asking plugin for UI Config Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 01:24:52 primo volumio[3176]: info: Getting Spotify Cloud Configuration Feb 22 01:24:52 primo volumio[3176]: info: Asking plugin for UI Config Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 01:24:52 primo volumio[3176]: info: Saving Spotify Acccount Feb 22 01:24:52 primo volumio[3176]: info: Got it Feb 22 01:24:52 primo volumio[3176]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 22 01:24:52 primo volumio[3176]: info: Got Tidal Cloud Configuration Feb 22 01:24:52 primo volumio[3176]: info: Got it Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::volumioGetBrowseSources Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::volumioGetBrowseSources Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::volumioGetBrowseSources Feb 22 01:24:52 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 22 01:24:53 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 22 01:24:56 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 22 01:24:57 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 22 01:24:57 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 22 01:24:59 primo volumio[3176]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L N1-CHM.local. -m SMB3_11 Feb 22 01:25:00 primo volumio[3176]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 22 01:25:03 primo volumio[3176]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 01:25:03 primo volumio[3176]: Error: dns service error: unknown Feb 22 01:25:03 primo volumio[3176]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Feb 22 01:25:03 primo volumio[3176]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Feb 22 01:25:03 primo volumio[3176]: errorCode: -65537 Feb 22 01:25:03 primo volumio[3176]: } Feb 22 01:25:03 primo volumio[3176]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 01:25:03 primo sudo[11573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-22 01:24 Feb 22 01:25:03 primo sudo[11573]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 03:02:44 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="16866c30bc20e3edc7c8c26f562b1b08"