-- Logs begin at Fri 2026-10-16 04:04:32 +07, end at Fri 2026-10-16 22:20:30 +07. --
Oct 16 22:19:02 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:02 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:03 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:03 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:03 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:19:03 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:05 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 16 22:19:06 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 16 22:19:06 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:06 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 16 22:19:06 volumio-living volumio[23197]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Oct 16 22:19:07 volumio-living volumio-remote-updater[660]: No test mode
Oct 16 22:19:07 volumio-living volumio-remote-updater[660]: No alpha test mode
Oct 16 22:19:07 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 16 22:19:07 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:07 volumio-living volumio[23197]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Oct 16 22:19:08 volumio-living volumio[23197]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Oct 16 22:19:08 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 16 22:19:09 volumio-living volumio[23197]: info: CoreCommandRouter::volumioGetState
Oct 16 22:19:09 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:10 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:10 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:10 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 16 22:19:10 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 16 22:19:10 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Oct 16 22:19:10 volumio-living volumio[23197]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 16 22:19:10 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 16 22:19:10 volumio-living volumio[23197]: info: MyVolumio token set successfully
Oct 16 22:19:10 volumio-living volumio[23197]: info: MYVOLUMIO: Adding device
Oct 16 22:19:10 volumio-living volumio[23197]: info: MYVOLUMIO: Evaluating Server
Oct 16 22:19:11 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:11 volumio-living volumio[23197]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Oct 16 22:19:11 volumio-living volumio[23197]: info: Completed starting MyVolumio Plugin
Oct 16 22:19:11 volumio-living volumio[23197]: [Metrics] CommandRouter: 42s 552.65ms
Oct 16 22:19:11 volumio-living volumio[23197]: info: CoreCommandRouter::volumiosetStartupVolume
Oct 16 22:19:11 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:11 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:11 volumio-living volumio[23197]: info: CoreCommandRouter::Close All Modals sent
Oct 16 22:19:11 volumio-living volumio[23197]: info: CoreCommandRouter::Close All Modals sent
Oct 16 22:19:12 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:12 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:12 volumio-living volumio[23197]: info: MyVolumio Plan changed: superstar
Oct 16 22:19:12 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar
Oct 16 22:19:12 volumio-living volumio[23197]: info: Adding audio output:
Oct 16 22:19:12 volumio-living volumio[23197]: info: MYVOLUMIO: Adding device
Oct 16 22:19:12 volumio-living volumio[23197]: info: MYVOLUMIO: Evaluating Server
Oct 16 22:19:12 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Oct 16 22:19:12 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 16 22:19:12 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Oct 16 22:19:13 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:13 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:13 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:19:16 volumio-living volumio[23197]: info: Setting Geolocation for MyVolumio to as1
Oct 16 22:19:16 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:16 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:16 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:17 volumio-living volumio[23197]: info: Setting Geolocation for MyVolumio to as1
Oct 16 22:19:17 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:17 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:17 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:17 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:17 volumio-living volumio[23197]: info: Remote config written successfully
Oct 16 22:19:17 volumio-living volumio[23197]: info: Starting Tunnel 1
Oct 16 22:19:17 volumio-living volumio[23197]: info: Starting Tunnel Connection Checker
Oct 16 22:19:17 volumio-living volumio[23197]: info: Updating MyVolumio device info
Oct 16 22:19:17 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:17 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:17 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:18 volumio-living volumio[23197]: info: Updating MyVolumio device info
Oct 16 22:19:18 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:18 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:19 volumio-living volumio[23197]: info: MYVolumio Device enabled
Oct 16 22:19:19 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Oct 16 22:19:19 volumio-living volumio[23197]: info: MyVolumio status changed
Oct 16 22:19:19 volumio-living volumio[23197]: info: Streaming services startup
Oct 16 22:19:19 volumio-living volumio[23197]: info: Starting Streaming Daemon
Oct 16 22:19:19 volumio-living sudo[23577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Oct 16 22:19:19 volumio-living sudo[23577]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:19 volumio-living sudo[23577]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:19 volumio-living volumio[23197]: info: BOOT COMPLETED
Oct 16 22:19:19 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:19 volumio-living volumio[23197]: error: Cannot start Volumio Streaming Daemon
Oct 16 22:19:19 volumio-living volumio[23197]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Oct 16 22:19:19 volumio-living volumio[23197]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Oct 16 22:19:20 volumio-living volumio[23197]: info: Successfully Added MyVolumio device
Oct 16 22:19:20 volumio-living volumio[23197]: info: Successfully Added MyVolumio device
Oct 16 22:19:24 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Oct 16 22:19:24 volumio-living volumio[23197]: error: [MyVolumio PluginManager] Cache data is invalid!
Oct 16 22:19:24 volumio-living volumio[23197]: error: Cannot delete local playlist /data/playlist/Tsai Ching : Error: ENOENT: no such file or directory, unlink '/data/playlist/Tsai Ching'
Oct 16 22:19:24 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:24 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:24 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:24 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:24 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:24 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:19:24 volumio-living volumio[23197]: info: Successfully Updated MyVolumio device
Oct 16 22:19:25 volumio-living volumio[23197]: info: Successfully Updated MyVolumio device
Oct 16 22:19:27 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:27 volumio-living sudo[23637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Oct 16 22:19:27 volumio-living sudo[23637]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:27 volumio-living autossh[15785]: received signal to exit (15)
Oct 16 22:19:27 volumio-living systemd[1]: Stopping MyVolumio SSH Tunnel...
Oct 16 22:19:27 volumio-living systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Oct 16 22:19:27 volumio-living systemd[1]: sshtunnel.service: Succeeded.
Oct 16 22:19:28 volumio-living systemd[1]: Stopped MyVolumio SSH Tunnel.
Oct 16 22:19:28 volumio-living systemd[1]: Started MyVolumio SSH Tunnel.
Oct 16 22:19:28 volumio-living sudo[23637]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:28 volumio-living autossh[23640]: port set to 0, monitoring disabled
Oct 16 22:19:28 volumio-living autossh[23640]: starting ssh (count 1)
Oct 16 22:19:28 volumio-living autossh[23640]: ssh child pid is 23643
Oct 16 22:19:28 volumio-living volumiossh-tunnel[23639]: Warning: Permanently added '[as1.myvolumio.org]:2222,[128.199.166.162]:2222' (RSA) to the list of known hosts.
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:31 volumio-living volumio[23197]: Cannot compose Albumart path
Oct 16 22:19:35 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Oct 16 22:19:35 volumio-living volumio[23197]: info: [1792163975740] Starting BluetoothController
Oct 16 22:19:35 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Oct 16 22:19:37 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Oct 16 22:19:37 volumio-living sudo[23661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Oct 16 22:19:37 volumio-living sudo[23661]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:37 volumio-living sudo[23661]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:37 volumio-living volumio[23197]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists
Oct 16 22:19:37 volumio-living volumio[23197]: info: MRS: MultiRoom plugin initialized
Oct 16 22:19:37 volumio-living volumio[23197]: info: MRS: STOPPING SNAPCLIENT
Oct 16 22:19:37 volumio-living volumio[23197]: info: MRS: Snap server stop
Oct 16 22:19:37 volumio-living sudo[23677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Oct 16 22:19:37 volumio-living sudo[23677]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:38 volumio-living volumio[23197]: info: MRS: STOPPING volumioStreaming
Oct 16 22:19:38 volumio-living sudo[23680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Oct 16 22:19:38 volumio-living sudo[23680]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:38 volumio-living sudo[23677]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:38 volumio-living sudo[23680]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:38 volumio-living sudo[23683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Oct 16 22:19:38 volumio-living sudo[23683]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Oct 16 22:19:38 volumio-living sudo[23683]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:38 volumio-living sudo[23686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Oct 16 22:19:38 volumio-living sudo[23686]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:38 volumio-living sudo[23686]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Oct 16 22:19:38 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"...
Oct 16 22:19:38 volumio-living volumio[23197]: info: Preparing to generate the ALSA configuration file
Oct 16 22:19:38 volumio-living volumio[23197]: info: Remote SSH Started
Oct 16 22:19:38 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Oct 16 22:19:38 volumio-living volumio[23197]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Oct 16 22:19:38 volumio-living volumio[23197]: info: Reading ALSA contributions from plugins.
Oct 16 22:19:38 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:38 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:38 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:38 volumio-living volumio[23197]: info: MRS: Removed streaming files
Oct 16 22:19:38 volumio-living volumio[23197]: info: MRS: volumioStreaming STOPPED
Oct 16 22:19:38 volumio-living volumio[23197]: info: MRS: SNAPSERVER STOPPED
Oct 16 22:19:38 volumio-living volumio[23197]: info: MRS: SNAPCLIENT STOPPED
Oct 16 22:19:38 volumio-living volumio[23197]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Oct 16 22:19:39 volumio-living volumio[23197]: info: CoreCommandRouter::volumioGetState
Oct 16 22:19:39 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:39 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:39 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:39 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:39 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:39 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:19:39 volumio-living volumio[23197]: info: Asound.conf file written
Oct 16 22:19:39 volumio-living sudo[23692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Oct 16 22:19:39 volumio-living sudo[23692]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:39 volumio-living sudo[23692]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:39 volumio-living volumio[23197]: info: Output device has changed, restarting MPD
Oct 16 22:19:39 volumio-living sudo[23697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 16 22:19:39 volumio-living sudo[23697]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:39 volumio-living sudo[23697]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:39 volumio-living volumio[23197]: info: Output device has changed, restarting Shairport Sync
Oct 16 22:19:39 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:39 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:39 volumio-living sudo[23700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 16 22:19:39 volumio-living sudo[23700]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:39 volumio-living systemd[1]: Stopping Music Player Daemon...
Oct 16 22:19:39 volumio-living volumio[23197]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 16 22:19:39 volumio-living volumio[23197]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Oct 16 22:19:39 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Oct 16 22:19:39 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 16 22:19:39 volumio-living systemd[1]: mpd.service: Succeeded.
Oct 16 22:19:39 volumio-living systemd[1]: Stopped Music Player Daemon.
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Oct 16 22:19:39 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Oct 16 22:19:39 volumio-living sudo[23709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio-Living
Oct 16 22:19:39 volumio-living sudo[23709]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:39 volumio-living systemd[1]: Starting Music Player Daemon...
Oct 16 22:19:39 volumio-living volumio[23197]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Oct 16 22:19:39 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding METAVOLUMIO REST API Endpoints
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Oct 16 22:19:39 volumio-living sudo[23709]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Oct 16 22:19:39 volumio-living volumio[23197]: info: Preparing CD Folders
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding CD REST API Endpoints
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Oct 16 22:19:39 volumio-living volumio[23197]: info: Starting UDEV Watcher for CD
Oct 16 22:19:39 volumio-living volumio[23197]: info: Detecting CD presence with UDEV
Oct 16 22:19:39 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Oct 16 22:19:39 volumio-living volumio[23197]: error: Hi Res Audio Failed Login: Missing Login Data
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding HIGHRESAUDIO REST API Endpoints
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Oct 16 22:19:39 volumio-living volumio[23197]: info: Refreshing TIDAL token
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Oct 16 22:19:39 volumio-living volumio[23197]: info: Refreshing QOBUZ token
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Oct 16 22:19:39 volumio-living volumio[23197]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect
Oct 16 22:19:39 volumio-living volumio[23197]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect
Oct 16 22:19:39 volumio-living sudo[23708]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 16 22:19:39 volumio-living sudo[23708]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:39 volumio-living sudo[23715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Oct 16 22:19:39 volumio-living sudo[23715]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:39 volumio-living sudo[23708]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:39 volumio-living volumio[23197]: info: QobuzConnect: Starting Qobuz Connect socket and service
Oct 16 22:19:39 volumio-living volumio[23197]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections
Oct 16 22:19:39 volumio-living systemd[1]: Stopping Volumio Tidal Connect Service...
Oct 16 22:19:39 volumio-living systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Oct 16 22:19:39 volumio-living sudo[23723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Oct 16 22:19:39 volumio-living systemd[1]: vtcs.service: Succeeded.
Oct 16 22:19:39 volumio-living systemd[1]: Stopped Volumio Tidal Connect Service.
Oct 16 22:19:39 volumio-living sudo[23723]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:39 volumio-living sudo[23715]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:39 volumio-living sudo[23723]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:40 volumio-living sudo[23726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Oct 16 22:19:40 volumio-living sudo[23726]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:40 volumio-living systemd[1]: Stopping Volumio Qobuz Connect Service...
Oct 16 22:19:40 volumio-living qobuz-connect[29496]: 20261016 22:19:40.037 [29496.29496] INFO SampleApp: Stopping Local configuration server
Oct 16 22:19:40 volumio-living systemd[1]: qobuz-connect.service: Succeeded.
Oct 16 22:19:40 volumio-living systemd[1]: Stopped Volumio Qobuz Connect Service.
Oct 16 22:19:40 volumio-living volumio[23197]: error: MPD error: Error: write EPIPE
Oct 16 22:19:40 volumio-living volumio[23197]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Oct 16 22:19:40 volumio-living systemd[1]: Started Volumio Qobuz Connect Service.
Oct 16 22:19:40 volumio-living sudo[23726]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:40 volumio-living volumio[23197]: info: Bluetooth name changed to Volumio-Living
Oct 16 22:19:40 volumio-living volumio[23197]: info: MPD Permissions set
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 22:19:40 volumio-living volumio[23197]: info: Executing endpoint qc_getconfig
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.495 [23728.23728] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.503 [23728.23728] INFO VolumeManager: [0xd9c040]: Setting new playback volume: 75
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.503 [23728.23728] INFO VolumeManager: [0xd9c040]: Setting new mute state: 0
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.503 [23728.23728] INFO AudioStreamManager: [0xd9bd98]: Setting new audio download buffer size: 1048576
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.503 [23728.23728] INFO QobuzConnect: [0xd9c908]: Client initialized!
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.503 [23728.23728] INFO SampleApp: Starting Avahi advertising, name: Volumio-Living, service name: _qobuz-connect._tcp
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.521 [23728.23728] INFO LocalConfigManager: [0xd9bac0]: Starting Local Configuration server
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.522 [23728.23728] INFO SampleApp: Starting Local configuration server
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.522 [23728.23728] INFO SampleApp: Connected to UNIX socket client 0xd91f60
Oct 16 22:19:40 volumio-living volumio[23197]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Oct 16 22:19:40 volumio-living volumio[23197]: info: QobuzConnect: QOBUZ Connect daemon connected
Oct 16 22:19:40 volumio-living volumio[23197]: info: Starting Shairport Sync
Oct 16 22:19:40 volumio-living qobuz-connect[23728]: 20261016 22:19:40.646 [23728.23728] INFO SampleApp: Playback volume changed: 75
Oct 16 22:19:40 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:40 volumio-living sudo[23742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 16 22:19:40 volumio-living sudo[23742]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::volumioGetState
Oct 16 22:19:40 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:40 volumio-living volumio[23197]: info: Access Token successfully retrieved
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 16 22:19:40 volumio-living volumio[23197]: info: [1792163980743] CoreMusicLibrary::Adding element QOBUZ
Oct 16 22:19:40 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 16 22:19:40 volumio-living volumio[23197]: Cannot find translation for source QOBUZ
Oct 16 22:19:40 volumio-living systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 16 22:19:40 volumio-living systemd[1]: shairport-sync.service: Succeeded.
Oct 16 22:19:40 volumio-living systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 16 22:19:40 volumio-living volumio[23197]: info: Stopping AccessToken refresher cron for QOBUZ
Oct 16 22:19:40 volumio-living systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 16 22:19:40 volumio-living sudo[23742]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:40 volumio-living volumio[23197]: info: AccessToken refresher cron started for QOBUZ
Oct 16 22:19:40 volumio-living volumio[23197]: info: Adding QOBUZ REST API Endpoints
Oct 16 22:19:40 volumio-living volumio[23197]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Oct 16 22:19:40 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:40 volumio-living volumio[23197]: info: Shairport-Sync Started
Oct 16 22:19:40 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:40 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:41 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:41 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:41 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:41 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:41 volumio-living volumio[23197]: Cast browser error: Error: getaddrinfo -3007
Oct 16 22:19:41 volumio-living volumio[23197]: info: Access Token successfully retrieved
Oct 16 22:19:41 volumio-living volumio[23197]: info: Successfully retrieved User Session From TIDAL
Oct 16 22:19:41 volumio-living mpd[23719]: Oct 16 22:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 16 22:19:41 volumio-living volumio[23197]: info: Successfully retrieved User Subscription From TIDAL
Oct 16 22:19:41 volumio-living volumio[23197]: info: Adding TIDAL to Browse Sources
Oct 16 22:19:41 volumio-living volumio[23197]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 16 22:19:41 volumio-living volumio[23197]: info: [1792163981792] CoreMusicLibrary::Adding element TIDAL
Oct 16 22:19:41 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 16 22:19:41 volumio-living volumio[23197]: Cannot find translation for source QOBUZ
Oct 16 22:19:41 volumio-living volumio[23197]: Cannot find translation for source TIDAL
Oct 16 22:19:41 volumio-living volumio[23197]: info: Adding TIDAL REST API Endpoints
Oct 16 22:19:41 volumio-living volumio[23197]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Oct 16 22:19:42 volumio-living systemd[1]: Started Music Player Daemon.
Oct 16 22:19:42 volumio-living sudo[23700]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:42 volumio-living volumio[23197]: error: updateQueue error: null
Oct 16 22:19:42 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:42 volumio-living sudo[23770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Oct 16 22:19:42 volumio-living sudo[23770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:42 volumio-living sudo[23770]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:42 volumio-living volumio[23197]: info: Volumio BT Module successfully started
Oct 16 22:19:43 volumio-living volumio[23197]: info: TidalConnect service stoped!
Oct 16 22:19:43 volumio-living volumio[23197]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Oct 16 22:19:43 volumio-living volumio[23197]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Oct 16 22:19:43 volumio-living sudo[23781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Oct 16 22:19:43 volumio-living sudo[23781]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:19:43 volumio-living systemd[1]: Started Volumio Tidal Connect Service.
Oct 16 22:19:43 volumio-living sudo[23781]: pam_unix(sudo:session): session closed for user root
Oct 16 22:19:43 volumio-living volumio[23197]: info: Executing endpoint tc_getconfig
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Oct 16 22:19:43 volumio-living vtcs[23783]: STARTING TidalConnect services, version: 1.6.1
Oct 16 22:19:43 volumio-living vtcs[23783]: STARTED TidalConnect services.
Oct 16 22:19:43 volumio-living volumio[23197]: info: Executing endpoint tc_connect
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Oct 16 22:19:43 volumio-living volumio[23197]: info: Connecting to TidalConnect
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreCommandRouter::servicePushState
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreStateMachine::pushState
Oct 16 22:19:43 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreCommandRouter::volumioPushState
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreCommandRouter::volumioGetState
Oct 16 22:19:43 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:43 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:43 volumio-living volumio[23197]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreCommandRouter::servicePushState
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreStateMachine::pushState
Oct 16 22:19:43 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreCommandRouter::volumioPushState
Oct 16 22:19:43 volumio-living volumio[23197]: info: CoreCommandRouter::volumioGetState
Oct 16 22:19:43 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:43 volumio-living volumio[23197]: info: CorePlayQueue::getTrack 0
Oct 16 22:19:43 volumio-living volumio[23197]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect
Oct 16 22:19:43 volumio-living volumio5-onboarding[1219]: time=2026-10-16T22:19:43.612+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.64:61140,192.168.1.64:61294,00:00:00:00:00:00%08 @ 0x332e030" state=STATUS_STOPPED positionMs=0 volume=29
Oct 16 22:19:43 volumio-living volumio5-onboarding[1219]: time=2026-10-16T22:19:43.616+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.64:61140,192.168.1.64:61294,00:00:00:00:00:00%08 @ 0x332e030" id="mnt/NAS/expansion/Music/1 SHM/SHM SACD - Starvinsky The Rite of Spring Boston Symphony Orchestra Seiji Ozawa - Stravinsky The Rite of Spring/Boston Symphony Orchestra Seiji Ozawa - Stravinsku The Rite of Spring (1 - Part 1 Introduction).dsf" title="Part 1 Introduction"
Oct 16 22:19:43 volumio-living volumio5-onboarding[1219]: time=2026-10-16T22:19:43.618+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.64:61140,192.168.1.64:61294,00:00:00:00:00:00%08 @ 0x332e030" state=STATUS_STOPPED positionMs=0 volume=29
Oct 16 22:19:43 volumio-living volumio5-onboarding[1219]: time=2026-10-16T22:19:43.618+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.64:61140,192.168.1.64:61294,00:00:00:00:00:00%08 @ 0x332e030" id="mnt/NAS/expansion/Music/1 SHM/SHM SACD - Starvinsky The Rite of Spring Boston Symphony Orchestra Seiji Ozawa - Stravinsky The Rite of Spring/Boston Symphony Orchestra Seiji Ozawa - Stravinsku The Rite of Spring (1 - Part 1 Introduction).dsf" title="Part 1 Introduction"
Oct 16 22:19:44 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:44 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:44 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:44 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:44 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:19:44 volumio-living volumio[23197]: info: MRS: Getting audio outputs on start
Oct 16 22:19:44 volumio-living volumio[23197]: info: MRS: Requesting all other devices output
Oct 16 22:19:46 volumio-living volumio[23197]: info: TidalConnect service started!
Oct 16 22:19:46 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:49 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:49 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:49 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:49 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:49 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:19:49 volumio-living nmbd[758]: [2026/10/16 22:19:49.882565, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Oct 16 22:19:49 volumio-living nmbd[758]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.36 for name WORKGROUP<1d>.
Oct 16 22:19:49 volumio-living nmbd[758]: This response was from IP 192.168.1.68, reporting an IP address of 192.168.1.68.
Oct 16 22:19:49 volumio-living nmbd[758]: [2026/10/16 22:19:49.883028, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Oct 16 22:19:49 volumio-living nmbd[758]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.70 for name WORKGROUP<1d>.
Oct 16 22:19:49 volumio-living nmbd[758]: This response was from IP 192.168.1.68, reporting an IP address of 192.168.1.68.
Oct 16 22:19:50 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:54 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:54 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:54 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:54 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:54 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:19:54 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:58 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:19:59 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:59 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:59 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:19:59 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:19:59 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:19:59 volumio-living volumio[23197]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Oct 16 22:20:02 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:20:04 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:04 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:04 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:04 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:04 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:20:06 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:20:09 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:09 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:09 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:09 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:09 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:20:10 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:20:14 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare
Oct 16 22:20:14 volumio-living volumio[23197]: info: Adding a new share
Oct 16 22:20:14 volumio-living volumio[23197]: info: Checking key NasMounts.af33630a-91f4-4c73-a1f8-a92551073ac9
Oct 16 22:20:14 volumio-living volumio[23197]: info: Checking key NasMounts.a486106a-9b87-4d5b-97c4-8aabae40ee57
Oct 16 22:20:14 volumio-living volumio[23197]: info: No correspondence found in configuration for share nas3b on IP 192.168.1.67
Oct 16 22:20:14 volumio-living volumio[23197]: info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.1.67 -N -m SMB3_11
Oct 16 22:20:14 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:14 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:14 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:14 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:14 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:20:14 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:20:17 volumio-living volumio[23197]: info: Negotiated SMB version with nas3b: SMB3_11
Oct 16 22:20:17 volumio-living volumio[23197]: info: Detected device nas3b with version SMB3_11
Oct 16 22:20:17 volumio-living volumio[23197]: info: Set SMB version 3.11 in CIFS options: vers=3.11
Oct 16 22:20:17 volumio-living sudo[23871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nas3b,password=5Chartchai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //192.168.1.67/media/nas3b/MyMusic /mnt/NAS/nas3b
Oct 16 22:20:17 volumio-living sudo[23871]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 22:20:17 volumio-living kernel: CIFS: Attempting to mount //192.168.1.67/media/nas3b/MyMusic
Oct 16 22:20:18 volumio-living kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.67\media
Oct 16 22:20:18 volumio-living sudo[23871]: pam_unix(sudo:session): session closed for user root
Oct 16 22:20:18 volumio-living volumio[23197]: info: Error mounting nas3b on IP 192.168.1.67 : (2): No such file or directory
Oct 16 22:20:18 volumio-living volumio[23197]: Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)
Oct 16 22:20:18 volumio-living kernel: CIFS: VFS: cifs_mount failed w/return code = -2
Oct 16 22:20:18 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:20:19 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Oct 16 22:20:19 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:19 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:19 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:19 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:19 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:20:22 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:20:24 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:24 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:24 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:24 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:24 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:20:26 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 16 22:20:29 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Oct 16 22:20:29 volumio-living volumio[23197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Oct 16 22:20:29 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:29 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:29 volumio-living volumio[23197]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Oct 16 22:20:29 volumio-living volumio[23197]: info: Discovery: Restarting Browsing
Oct 16 22:20:29 volumio-living volumio[23197]: info: Discovery: Restart already pending, ignoring duplicate call
Oct 16 22:20:29 volumio-living volumio[23197]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 16 22:20:29 volumio-living volumio[23197]: Error: getaddrinfo -3007
Oct 16 22:20:29 volumio-living volumio[23197]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Oct 16 22:20:29 volumio-living volumio[23197]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Oct 16 22:20:29 volumio-living volumio[23197]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Oct 16 22:20:29 volumio-living volumio[23197]: code: -3007,
Oct 16 22:20:29 volumio-living volumio[23197]: errno: -3007,
Oct 16 22:20:29 volumio-living volumio[23197]: syscall: 'getaddrinfo'
Oct 16 22:20:29 volumio-living volumio[23197]: }
Oct 16 22:20:29 volumio-living volumio[23197]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 16 22:20:30 volumio-living sudo[23977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-16 22:19
Oct 16 22:20:30 volumio-living sudo[23977]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET"
VOLUMIO_VERSION="3.912"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"