-- Logs begin at Wed 2026-01-28 19:56:34 UTC, end at Wed 2026-01-28 19:58:22 UTC. --
Jan 28 19:57:02 volumio dhcpcd[875]: wlan0: using IPv4LL address 169.254.162.173
Jan 28 19:57:02 volumio dhcpcd[875]: wlan0: adding route to 169.254.0.0/16
Jan 28 19:57:02 volumio avahi-daemon[740]: Registering new address record for 169.254.162.173 on wlan0.IPv4.
Jan 28 19:57:03 volumio sudo[1551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 28 19:57:03 volumio sudo[1551]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:03 volumio sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 28 19:57:03 volumio sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:03 volumio systemd[1]: Started MPD Monitor Service.
Jan 28 19:57:03 volumio sudo[1551]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:03 volumio mpd_monitor.sh[1556]: MPD Monitor Service: Starting MPD Monitor Service
Jan 28 19:57:03 volumio volumio[1041]: info: Successfully started MPD Monitor
Jan 28 19:57:03 volumio systemd[1]: Stopping MPD Monitor Service...
Jan 28 19:57:03 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM
Jan 28 19:57:03 volumio systemd[1]: mpd_monitor.service: Succeeded.
Jan 28 19:57:03 volumio systemd[1]: Stopped MPD Monitor Service.
Jan 28 19:57:03 volumio systemd[1]: Started MPD Monitor Service.
Jan 28 19:57:03 volumio sudo[1553]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:03 volumio volumio[1041]: info: Successfully started MPD Monitor
Jan 28 19:57:03 volumio mpd_monitor.sh[1559]: MPD Monitor Service: Starting MPD Monitor Service
Jan 28 19:57:03 volumio ntpd[1326]: Listen normally on 5 wlan0 169.254.162.173:123
Jan 28 19:57:03 volumio ntpd[1326]: new interface(s) found: waking up resolver
Jan 28 19:57:05 volumio volumio[1041]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jan 28 19:57:06 volumio sudo[1578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 28 19:57:06 volumio sudo[1578]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:06 volumio sudo[1578]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:06 volumio sudo[1580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 28 19:57:06 volumio sudo[1580]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:06 volumio sudo[1580]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:06 volumio sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jan 28 19:57:06 volumio sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:06 volumio sudo[1584]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:06 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jan 28 19:57:06 volumio volumio[1041]: info: Upmpdcli Daemon Started
Jan 28 19:57:06 volumio volumio[1586]: Generating RSA private key, 4096 bit long modulus (2 primes)
Jan 28 19:57:08 volumio volumio[1586]: ........................................................................................................................................++++
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jan 28 19:57:08 volumio volumio[1041]: info: Adding plugin bluetooth to MyMusic Plugins
Jan 28 19:57:08 volumio volumio[1041]: info: Adding plugin multiroom to MyMusic Plugins
Jan 28 19:57:08 volumio volumio[1041]: info: Adding plugin metavolumio to MyMusic Plugins
Jan 28 19:57:08 volumio volumio[1041]: info: Adding plugin cd_controller to MyMusic Plugins
Jan 28 19:57:08 volumio volumio[1041]: info: Adding plugin qobuzconnect to MyMusic Plugins
Jan 28 19:57:08 volumio volumio[1041]: info: Adding plugin smart_inputs to MyMusic Plugins
Jan 28 19:57:08 volumio volumio[1041]: info: Adding plugin tidalconnect to MyMusic Plugins
Jan 28 19:57:08 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jan 28 19:57:09 volumio volumio[1041]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jan 28 19:57:09 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jan 28 19:57:09 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:09 volumio volumio[1041]: info: Starting MyVolumio Remote Streaming Endpoints
Jan 28 19:57:09 volumio volumio[1041]: info: MyVolumio login type: Token
Jan 28 19:57:09 volumio volumio[1041]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jan 28 19:57:09 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jan 28 19:57:09 volumio volumio[1586]: ....................................................................................................................................................................++++
Jan 28 19:57:09 volumio volumio[1586]: e is 65537 (0x010001)
Jan 28 19:57:09 volumio volumio[1586]: writing RSA key
Jan 28 19:57:09 volumio volumio[1041]: info: Starting Streaming Service Transparent Proxy
Jan 28 19:57:09 volumio volumio[1041]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jan 28 19:57:09 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jan 28 19:57:09 volumio volumio[1041]: info: Streaming services startup
Jan 28 19:57:09 volumio volumio[1041]: info: Starting Streaming Daemon
Jan 28 19:57:09 volumio sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jan 28 19:57:09 volumio sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:10 volumio volumio[1041]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Jan 28 19:57:10 volumio sudo[1624]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:10 volumio volumio[1041]: error: Cannot start Volumio Streaming Daemon
Jan 28 19:57:10 volumio volumio[1041]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jan 28 19:57:10 volumio volumio[1041]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jan 28 19:57:10 volumio volumio[1041]: STREAMING PROXY: Starting server on port 3245
Jan 28 19:57:10 volumio volumio[1041]: Node JS runtime: 14
Jan 28 19:57:10 volumio volumio[1041]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jan 28 19:57:10 volumio volumio[1041]: info: MyVolumio token set successfully
Jan 28 19:57:10 volumio volumio[1041]: info: MYVOLUMIO: Adding device
Jan 28 19:57:10 volumio volumio[1041]: info: MYVOLUMIO: Evaluating Server
Jan 28 19:57:11 volumio volumio[1041]: info: MyVolumio Plan changed: premium
Jan 28 19:57:11 volumio volumio[1041]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Jan 28 19:57:11 volumio volumio[1041]: info: Removing browser output: myVolumio user plan is not superstar
Jan 28 19:57:11 volumio volumio[1041]: info: Removing audio output:
Jan 28 19:57:11 volumio volumio[1041]: info: MYVOLUMIO: Adding device
Jan 28 19:57:11 volumio volumio[1041]: info: MYVOLUMIO: Evaluating Server
Jan 28 19:57:11 volumio volumio[1041]: info: Remote config written successfully
Jan 28 19:57:11 volumio volumio[1041]: info: Starting Tunnel 1
Jan 28 19:57:11 volumio volumio[1041]: info: Starting Tunnel Connection Checker
Jan 28 19:57:11 volumio volumio[1041]: info: Completed starting MyVolumio Plugin
Jan 28 19:57:11 volumio volumio[1041]: info: MYVolumio Device enabled
Jan 28 19:57:11 volumio volumio[1041]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Jan 28 19:57:11 volumio volumio[1041]: info: MyVolumio status changed
Jan 28 19:57:11 volumio volumio[1041]: info: Streaming services startup
Jan 28 19:57:11 volumio volumio[1041]: info: Starting Streaming Daemon
Jan 28 19:57:11 volumio volumio[1041]: info: Setting Geolocation for MyVolumio to eu9
Jan 28 19:57:11 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:11 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:11 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:11 volumio sudo[1691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jan 28 19:57:11 volumio sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:11 volumio sudo[1691]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:11 volumio volumio[1041]: error: Cannot start Volumio Streaming Daemon
Jan 28 19:57:11 volumio volumio[1041]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jan 28 19:57:11 volumio volumio[1041]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jan 28 19:57:11 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Jan 28 19:57:11 volumio volumio[1041]: error: [MyVolumio PluginManager] Cache data is invalid!
Jan 28 19:57:11 volumio volumio[1041]: info: Setting Geolocation for MyVolumio to eu8
Jan 28 19:57:11 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:11 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:11 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:11 volumio volumio[1041]: info: Successfully Added MyVolumio device
Jan 28 19:57:12 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Jan 28 19:57:12 volumio volumio[1041]: info: [1769630232388] Starting BluetoothController
Jan 28 19:57:12 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Jan 28 19:57:13 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Jan 28 19:57:14 volumio sudo[1697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Jan 28 19:57:14 volumio sudo[1697]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:14 volumio sudo[1697]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: MultiRoom plugin initialized
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: STOPPING SNAPCLIENT
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: Snap server stop
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: STOPPING volumioStreaming
Jan 28 19:57:14 volumio sudo[1720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Jan 28 19:57:14 volumio sudo[1720]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:14 volumio sudo[1722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Jan 28 19:57:14 volumio sudo[1725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Jan 28 19:57:14 volumio sudo[1722]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:14 volumio sudo[1720]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Jan 28 19:57:14 volumio sudo[1725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:14 volumio sudo[1728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Jan 28 19:57:14 volumio sudo[1728]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:14 volumio sudo[1728]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:14 volumio sudo[1722]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Jan 28 19:57:14 volumio sudo[1725]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"...
Jan 28 19:57:14 volumio volumio[1041]: info: Preparing to generate the ALSA configuration file
Jan 28 19:57:14 volumio volumio[1041]: info: Updating MyVolumio device info
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:14 volumio volumio[1041]: info: Updating MyVolumio device info
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Jan 28 19:57:14 volumio volumio[1041]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 28 19:57:14 volumio volumio[1041]: info: Reading ALSA contributions from plugins.
Jan 28 19:57:14 volumio volumio[1041]: info: Successfully Added MyVolumio device
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: Removed streaming files
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: volumioStreaming STOPPED
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: SNAPSERVER STOPPED
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: SNAPCLIENT STOPPED
Jan 28 19:57:14 volumio volumio[1041]: info: Asound.conf file unchanged, so no further update is needed
Jan 28 19:57:14 volumio volumio[1041]: info: Output device has changed, restarting MPD
Jan 28 19:57:14 volumio volumio[1041]: info: Output device has changed, restarting Shairport Sync
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:14 volumio sudo[1732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 28 19:57:14 volumio sudo[1732]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:14 volumio sudo[1732]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:14 volumio sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 28 19:57:14 volumio sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:14 volumio systemd[1]: Stopping Music Player Daemon...
Jan 28 19:57:14 volumio volumio[1041]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 28 19:57:14 volumio volumio[1041]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:14 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Jan 28 19:57:14 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Jan 28 19:57:15 volumio volumio[1041]: info: MRS: Pushing multiroomSync output for this device
Jan 28 19:57:15 volumio volumio[1041]: info: MRS: Pushing multiroomSync output
Jan 28 19:57:15 volumio volumio[1041]: info: Adding audio output:
Jan 28 19:57:15 volumio volumio[1041]: info: Adding audio output:
Jan 28 19:57:15 volumio volumio[1041]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Jan 28 19:57:15 volumio volumio[1041]: info: Adding METAVOLUMIO REST API Endpoints
Jan 28 19:57:15 volumio volumio[1041]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Jan 28 19:57:15 volumio volumio[1041]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Jan 28 19:57:15 volumio volumio[1041]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Jan 28 19:57:15 volumio volumio[1041]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Jan 28 19:57:15 volumio volumio[1041]: info: Preparing CD Folders
Jan 28 19:57:15 volumio volumio[1041]: info: Adding CD REST API Endpoints
Jan 28 19:57:15 volumio volumio[1041]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Jan 28 19:57:15 volumio volumio[1041]: info: Starting UDEV Watcher for CD
Jan 28 19:57:15 volumio volumio[1041]: info: Detecting CD presence with UDEV
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Jan 28 19:57:15 volumio volumio[1041]: info: Adding inputs REST Endpoints
Jan 28 19:57:15 volumio volumio[1041]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Jan 28 19:57:15 volumio volumio[1041]: info: Scanning Audio Inputs
Jan 28 19:57:15 volumio sudo[1743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio
Jan 28 19:57:15 volumio sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio systemd[1]: mpd.service: Succeeded.
Jan 28 19:57:15 volumio systemd[1]: Stopped Music Player Daemon.
Jan 28 19:57:15 volumio volumio[1041]: info: Checking against Known Cards name
Jan 28 19:57:15 volumio systemd[1]: Starting Music Player Daemon...
Jan 28 19:57:15 volumio volumio[1041]: info: Checking against Known Cards name
Jan 28 19:57:15 volumio volumio[1041]: info: Adding Server instance for streaming
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Jan 28 19:57:15 volumio volumio[1041]: info: Adding HIGHRESAUDIO REST API Endpoints
Jan 28 19:57:15 volumio volumio[1041]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Jan 28 19:57:15 volumio volumio[1041]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Jan 28 19:57:15 volumio volumio[1041]: info: Refreshing QOBUZ token
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Jan 28 19:57:15 volumio volumio[1041]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect
Jan 28 19:57:15 volumio volumio[1041]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect
Jan 28 19:57:15 volumio sudo[1752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jan 28 19:57:15 volumio sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio sudo[1750]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 28 19:57:15 volumio sudo[1750]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio sudo[1750]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:15 volumio sudo[1743]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio volumio[1041]: info: QobuzConnect: Starting Qobuz Connect socket and service
Jan 28 19:57:15 volumio sudo[1752]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio volumio[1041]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections
Jan 28 19:57:15 volumio volumio[1041]: info: Adding TIDAL REST API Endpoints
Jan 28 19:57:15 volumio volumio[1041]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Jan 28 19:57:15 volumio volumio[1041]: info: Bluetooth name changed to Volumio
Jan 28 19:57:15 volumio volumio[1041]: info: MPD Permissions set
Jan 28 19:57:15 volumio sudo[1761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 28 19:57:15 volumio sudo[1761]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:15 volumio sudo[1761]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:15 volumio sudo[1764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jan 28 19:57:15 volumio sudo[1764]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:15 volumio systemd[1]: Started Volumio Qobuz Connect Service.
Jan 28 19:57:15 volumio sudo[1764]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio volumio[1041]: info: Starting Shairport Sync
Jan 28 19:57:15 volumio sudo[1773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 28 19:57:15 volumio sudo[1773]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio volumio[1041]: info: Preparing to generate the ALSA configuration file
Jan 28 19:57:15 volumio volumio[1041]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 28 19:57:15 volumio volumio[1041]: info: Reading ALSA contributions from plugins.
Jan 28 19:57:15 volumio volumio[1041]: info: Access Token successfully retrieved
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 28 19:57:15 volumio volumio[1041]: info: [1769630235583] CoreMusicLibrary::Adding element QOBUZ
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 19:57:15 volumio volumio[1041]: Cannot find translation for source QOBUZ
Jan 28 19:57:15 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 28 19:57:15 volumio systemd[1]: shairport-sync.service: Succeeded.
Jan 28 19:57:15 volumio volumio[1041]: info: Stopping AccessToken refresher cron for QOBUZ
Jan 28 19:57:15 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 28 19:57:15 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 28 19:57:15 volumio sudo[1773]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio volumio[1041]: info: AccessToken refresher cron started for QOBUZ
Jan 28 19:57:15 volumio volumio[1041]: info: Adding QOBUZ REST API Endpoints
Jan 28 19:57:15 volumio volumio[1041]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Jan 28 19:57:15 volumio volumio[1041]: info: Successfully Updated MyVolumio device
Jan 28 19:57:15 volumio volumio[1041]: error: Hi Res Audio Failed Login: [object Object]
Jan 28 19:57:15 volumio volumio[1041]: info: Successfully Updated MyVolumio device
Jan 28 19:57:15 volumio volumio[1041]: info: Shairport-Sync Started
Jan 28 19:57:15 volumio volumio[1041]: info: Executing endpoint qc_getconfig
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.780 [1771.1771] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 28 19:57:15 volumio volumio[1041]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 28 19:57:15 volumio volumio[1041]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 28 19:57:15 volumio volumio[1041]: info: Asound.conf file written
Jan 28 19:57:15 volumio sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jan 28 19:57:15 volumio sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio sudo[1782]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio mpd[1756]: Jan 28 19:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jan 28 19:57:15 volumio systemd[1]: Started Music Player Daemon.
Jan 28 19:57:15 volumio sudo[1734]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio volumio[1041]: Found hardware: "HDA-Intel" "Realtek ALC233" "HDA:10ec0235,1019a4c6,00100002 HDA:8086280d,80860101,00100000" "0x1019" "0xa4c6"
Jan 28 19:57:15 volumio volumio[1041]: Hardware is initialized using a generic method
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #33 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #34 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #35 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #36 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #37 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #38 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #39 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #40 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #41 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #42 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #43 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #44 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #48 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #49 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:0008" "" ""
Jan 28 19:57:15 volumio volumio[1041]: Hardware is initialized using a generic method
Jan 28 19:57:15 volumio volumio[1041]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #7 (No such file or directory)
Jan 28 19:57:15 volumio volumio[1041]: info: Output device has changed, restarting MPD
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.901 [1771.1771] INFO VolumeManager: [0x5592435e4f50]: Setting new playback volume: 75
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.901 [1771.1771] INFO VolumeManager: [0x5592435e4f50]: Setting new mute state: 0
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.901 [1771.1771] INFO QobuzConnect: [0x5592435e6170]: Client initialized!
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.901 [1771.1771] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.906 [1771.1771] INFO LocalConfigManager: [0x5592435e4240]: Starting Local Configuration server
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.907 [1771.1771] INFO SampleApp: Starting Local configuration server
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.907 [1771.1771] INFO SampleApp: Connected to UNIX socket client 0x5592435cc280
Jan 28 19:57:15 volumio volumio[1041]: info: Output device has changed, restarting Shairport Sync
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:15 volumio sudo[1789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 28 19:57:15 volumio sudo[1789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio sudo[1789]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:15 volumio qobuz-connect[1771]: 20260128 19:57:15.930 [1771.1771] INFO SampleApp: Playback volume changed: 75
Jan 28 19:57:15 volumio sudo[1791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 28 19:57:15 volumio sudo[1791]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:15 volumio volumio[1041]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 28 19:57:15 volumio volumio[1041]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:15 volumio systemd[1]: Stopping Music Player Daemon...
Jan 28 19:57:15 volumio volumio[1041]: info: QobuzConnect: setDeactiveState invoked
Jan 28 19:57:15 volumio systemd[1]: mpd.service: Succeeded.
Jan 28 19:57:15 volumio systemd[1]: Stopped Music Player Daemon.
Jan 28 19:57:15 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:15 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:15 volumio volumio[1041]: info: Preparing to generate the ALSA configuration file
Jan 28 19:57:15 volumio systemd[1]: Starting Music Player Daemon...
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:16 volumio sudo[1800]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 28 19:57:16 volumio sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio sudo[1800]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:16 volumio volumio[1041]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 28 19:57:16 volumio volumio[1041]: info: Reading ALSA contributions from plugins.
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:16 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:16 volumio volumio[1041]: info: MPD Permissions set
Jan 28 19:57:16 volumio sudo[1807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 28 19:57:16 volumio sudo[1807]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:16 volumio sudo[1807]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:16 volumio sudo[1810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 28 19:57:16 volumio sudo[1810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jan 28 19:57:16 volumio systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 28 19:57:16 volumio qobuz-connect[1771]: 20260128 19:57:16.146 [1771.1771] INFO SampleApp: Stopping Local configuration server
Jan 28 19:57:16 volumio qobuz-connect[1771]: 20260128 19:57:16.157 [1771.1771] INFO SampleApp: shat down connection on UNIX socket
Jan 28 19:57:16 volumio systemd[1]: qobuz-connect.service: Succeeded.
Jan 28 19:57:16 volumio systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:16 volumio systemd[1]: Started Volumio Qobuz Connect Service.
Jan 28 19:57:16 volumio sudo[1810]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: setDeactiveState invoked
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:16 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:16 volumio volumio[1041]: info: Starting Shairport Sync
Jan 28 19:57:16 volumio volumio[1041]: info: Executing endpoint qc_getconfig
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 28 19:57:16 volumio sudo[1820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 28 19:57:16 volumio sudo[1820]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 28 19:57:16 volumio systemd[1]: shairport-sync.service: Succeeded.
Jan 28 19:57:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 28 19:57:16 volumio volumio[1041]: info: Asound.conf file unchanged, so no further update is needed
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.307 [1817.1817] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.309 [1817.1817] INFO VolumeManager: [0x55e70122df50]: Setting new playback volume: 75
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.309 [1817.1817] INFO VolumeManager: [0x55e70122df50]: Setting new mute state: 0
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.309 [1817.1817] INFO QobuzConnect: [0x55e70122f170]: Client initialized!
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.309 [1817.1817] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp
Jan 28 19:57:16 volumio sudo[1820]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:16 volumio volumio[1041]: info: Output device has changed, restarting MPD
Jan 28 19:57:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.331 [1817.1817] INFO LocalConfigManager: [0x55e70122d240]: Starting Local Configuration server
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.331 [1817.1817] INFO SampleApp: Starting Local configuration server
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.332 [1817.1817] INFO SampleApp: Connected to UNIX socket client 0x55e701215280
Jan 28 19:57:16 volumio sudo[1828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 28 19:57:16 volumio sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio volumio[1041]: info: Output device has changed, restarting Shairport Sync
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:16 volumio sudo[1828]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:16 volumio sudo[1831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 28 19:57:16 volumio sudo[1831]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.457 [1817.1817] INFO SampleApp: Playback volume changed: 75
Jan 28 19:57:16 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jan 28 19:57:16 volumio systemd[1]: mpd.service: Succeeded.
Jan 28 19:57:16 volumio systemd[1]: Stopped Music Player Daemon.
Jan 28 19:57:16 volumio volumio[1041]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 28 19:57:16 volumio systemd[1]: Starting Music Player Daemon...
Jan 28 19:57:16 volumio volumio[1041]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: setDeactiveState invoked
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:16 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:16 volumio sudo[1837]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 28 19:57:16 volumio sudo[1837]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio sudo[1837]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:16 volumio sudo[1845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 28 19:57:16 volumio sudo[1845]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 28 19:57:16 volumio volumio[1041]: info: MPD Permissions set
Jan 28 19:57:16 volumio volumio[1041]: info: Shairport-Sync Started
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:16 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:16 volumio sudo[1845]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:16 volumio sudo[1849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 28 19:57:16 volumio sudo[1849]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.658 [1817.1817] INFO SampleApp: Stopping Local configuration server
Jan 28 19:57:16 volumio qobuz-connect[1817]: 20260128 19:57:16.669 [1817.1817] INFO SampleApp: shat down connection on UNIX socket
Jan 28 19:57:16 volumio systemd[1]: qobuz-connect.service: Succeeded.
Jan 28 19:57:16 volumio systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:16 volumio systemd[1]: Started Volumio Qobuz Connect Service.
Jan 28 19:57:16 volumio sudo[1849]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: setDeactiveState invoked
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:16 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:16 volumio volumio[1041]: info: Executing endpoint qc_getconfig
Jan 28 19:57:16 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 28 19:57:16 volumio qobuz-connect[1853]: 20260128 19:57:16.857 [1853.1853] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 28 19:57:16 volumio qobuz-connect[1853]: 20260128 19:57:16.859 [1853.1853] INFO VolumeManager: [0x56190ab6ef50]: Setting new playback volume: 75
Jan 28 19:57:16 volumio qobuz-connect[1853]: 20260128 19:57:16.859 [1853.1853] INFO VolumeManager: [0x56190ab6ef50]: Setting new mute state: 0
Jan 28 19:57:16 volumio qobuz-connect[1853]: 20260128 19:57:16.859 [1853.1853] INFO QobuzConnect: [0x56190ab70170]: Client initialized!
Jan 28 19:57:16 volumio qobuz-connect[1853]: 20260128 19:57:16.859 [1853.1853] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp
Jan 28 19:57:16 volumio volumio[1041]: info: Starting Shairport Sync
Jan 28 19:57:16 volumio qobuz-connect[1853]: 20260128 19:57:16.869 [1853.1853] INFO LocalConfigManager: [0x56190ab6e240]: Starting Local Configuration server
Jan 28 19:57:16 volumio qobuz-connect[1853]: 20260128 19:57:16.869 [1853.1853] INFO SampleApp: Starting Local configuration server
Jan 28 19:57:16 volumio qobuz-connect[1853]: 20260128 19:57:16.869 [1853.1853] INFO SampleApp: Connected to UNIX socket client 0x56190ab56280
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 28 19:57:16 volumio volumio[1041]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 28 19:57:16 volumio sudo[1880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 28 19:57:16 volumio sudo[1880]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 28 19:57:16 volumio systemd[1]: shairport-sync.service: Succeeded.
Jan 28 19:57:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 28 19:57:17 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:17 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:17 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 28 19:57:17 volumio qobuz-connect[1853]: 20260128 19:57:17.007 [1853.1853] INFO SampleApp: Playback volume changed: 75
Jan 28 19:57:17 volumio sudo[1880]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:17 volumio volumio[1041]: info: Shairport-Sync Started
Jan 28 19:57:17 volumio sudo[1884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Jan 28 19:57:17 volumio sudo[1884]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:17 volumio systemd[1]: Started MyVolumio SSH Tunnel.
Jan 28 19:57:17 volumio sudo[1884]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:17 volumio volumio[1041]: info: Remote SSH Started
Jan 28 19:57:17 volumio autossh[1890]: port set to 0, monitoring disabled
Jan 28 19:57:17 volumio autossh[1890]: starting ssh (count 1)
Jan 28 19:57:17 volumio autossh[1890]: ssh child pid is 1896
Jan 28 19:57:17 volumio mpd[1846]: Jan 28 19:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jan 28 19:57:17 volumio volumio[1041]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Jan 28 19:57:17 volumio sudo[1831]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:17 volumio systemd[1]: Started Music Player Daemon.
Jan 28 19:57:17 volumio sudo[1791]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:17 volumio volumio[1041]: error: updateQueue error: null
Jan 28 19:57:17 volumio volumio[1041]: error: MPD error: The expression evaluated to a falsy value:
Jan 28 19:57:17 volumio volumio[1041]: assert.ok(self.idling)
Jan 28 19:57:17 volumio volumio[1041]: error: The expression evaluated to a falsy value:
Jan 28 19:57:17 volumio volumio[1041]: assert.ok(self.idling)
Jan 28 19:57:17 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:17 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:17 volumio volumio[1041]: error: updateQueue error: null
Jan 28 19:57:17 volumio volumiossh-tunnel[1888]: Warning: Permanently added '[eu8.myvolumio.org]:2222,[178.62.246.67]:2222' (RSA) to the list of known hosts.
Jan 28 19:57:18 volumio sudo[1933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Jan 28 19:57:18 volumio sudo[1933]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:18 volumio systemd[1]: Started Volumio Bluetooth Module.
Jan 28 19:57:18 volumio sudo[1933]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:18 volumio volumio[1041]: info: Volumio BT Module successfully started
Jan 28 19:57:18 volumio volumio[1041]: info: TidalConnect service stoped!
Jan 28 19:57:18 volumio volumio[1041]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Jan 28 19:57:18 volumio volumio[1041]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Jan 28 19:57:18 volumio sudo[1954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Jan 28 19:57:18 volumio sudo[1954]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:18 volumio systemd[1]: Started Volumio Tidal Connect Service.
Jan 28 19:57:18 volumio sudo[1954]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:18 volumio sudo[1967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Jan 28 19:57:18 volumio sudo[1967]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:18 volumio volumiobt[1944]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Jan 28 19:57:18 volumio sudo[1967]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:18 volumio volumio[1041]: info: Executing endpoint tc_getconfig
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Jan 28 19:57:18 volumio vtcs[1956]: STARTING TidalConnect services, version: 1.5.2.56
Jan 28 19:57:18 volumio vtcs[1956]: STARTED TidalConnect services.
Jan 28 19:57:18 volumio volumio[1041]: info: Executing endpoint tc_connect
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Jan 28 19:57:18 volumio volumio[1041]: info: Connecting to TidalConnect
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::servicePushState
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::pushState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioPushState
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output update for this device
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Jan 28 19:57:18 volumio volumio[1041]: verbose: CURRENT POSITION 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::syncState stateService stop
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::pushState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioPushState
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output update for this device
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: No code
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::pushState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioPushState
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output update for this device
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::servicePushState
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::pushState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioPushState
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output update for this device
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Jan 28 19:57:18 volumio volumio[1041]: verbose: CURRENT POSITION 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::syncState stateService stop
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::pushState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioPushState
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output update for this device
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: No code
Jan 28 19:57:18 volumio volumio[1041]: info: CoreStateMachine::pushState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioPushState
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output update for this device
Jan 28 19:57:18 volumio volumio[1041]: info: MRS: Pushing multiroomSync output
Jan 28 19:57:18 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:18 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:19 volumio sudo[2001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 28 19:57:19 volumio sudo[2001]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:19 volumio systemd[1]: Stopping MPD Monitor Service...
Jan 28 19:57:19 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM
Jan 28 19:57:19 volumio systemd[1]: mpd_monitor.service: Succeeded.
Jan 28 19:57:19 volumio systemd[1]: Stopped MPD Monitor Service.
Jan 28 19:57:19 volumio volumio[1041]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 28 19:57:19 volumio volumio[1041]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 28 19:57:19 volumio systemd[1]: Started MPD Monitor Service.
Jan 28 19:57:19 volumio sudo[2001]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:19 volumio mpd_monitor.sh[2003]: MPD Monitor Service: Starting MPD Monitor Service
Jan 28 19:57:19 volumio volumio[1041]: info: Successfully started MPD Monitor
Jan 28 19:57:19 volumio sudo[2007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Jan 28 19:57:19 volumio sudo[2007]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:19 volumio volumiobt[1944]: pulseaudio: no process found
Jan 28 19:57:19 volumio sudo[2007]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:19 volumio dbus-daemon[738]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.28' (uid=1000 pid=2011 comm="/usr/bin/pulseaudio --high-priority=true ")
Jan 28 19:57:19 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Jan 28 19:57:19 volumio volumio[1041]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 28 19:57:19 volumio dbus-daemon[738]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Jan 28 19:57:19 volumio rtkit-daemon[2014]: Successfully called chroot.
Jan 28 19:57:19 volumio rtkit-daemon[2014]: Successfully dropped privileges.
Jan 28 19:57:19 volumio rtkit-daemon[2014]: Successfully limited resources.
Jan 28 19:57:19 volumio rtkit-daemon[2014]: Running.
Jan 28 19:57:19 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service.
Jan 28 19:57:19 volumio rtkit-daemon[2014]: Canary thread running.
Jan 28 19:57:19 volumio rtkit-daemon[2014]: Watchdog thread running.
Jan 28 19:57:19 volumio dbus-daemon[738]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.29' (uid=0 pid=2014 comm="/usr/lib/rtkit/rtkit-daemon ")
Jan 28 19:57:19 volumio systemd[1]: Starting Authorization Manager...
Jan 28 19:57:19 volumio volumio[1041]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 28 19:57:20 volumio volumio[1041]: info: MRS: Getting audio outputs on start
Jan 28 19:57:20 volumio volumio[1041]: info: MRS: Requesting all other devices output
Jan 28 19:57:20 volumio polkitd[2023]: started daemon version 0.105 using authority implementation `local' version `0.105'
Jan 28 19:57:20 volumio dbus-daemon[738]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jan 28 19:57:20 volumio systemd[1]: Started Authorization Manager.
Jan 28 19:57:20 volumio sudo[2033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 28 19:57:20 volumio sudo[2033]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:20 volumio sudo[2036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 28 19:57:20 volumio sudo[2036]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 28 19:57:20 volumio systemd[1]: Stopping MPD Monitor Service...
Jan 28 19:57:20 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM
Jan 28 19:57:20 volumio systemd[1]: mpd_monitor.service: Succeeded.
Jan 28 19:57:20 volumio systemd[1]: Stopped MPD Monitor Service.
Jan 28 19:57:20 volumio volumio[1041]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 28 19:57:20 volumio volumio[1041]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 28 19:57:20 volumio volumio[1041]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 28 19:57:20 volumio systemd[1]: Started MPD Monitor Service.
Jan 28 19:57:20 volumio sudo[2036]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:20 volumio mpd_monitor.sh[2038]: MPD Monitor Service: Starting MPD Monitor Service
Jan 28 19:57:20 volumio sudo[2033]: pam_unix(sudo:session): session closed for user root
Jan 28 19:57:20 volumio volumio[1041]: info: Successfully started MPD Monitor
Jan 28 19:57:20 volumio volumio[1041]: info: Successfully started MPD Monitor
Jan 28 19:57:20 volumio pulseaudio[2011]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jan 28 19:57:20 volumio pulseaudio[2011]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jan 28 19:57:20 volumio bluetoothd[743]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSource
Jan 28 19:57:20 volumio bluetoothd[743]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSink
Jan 28 19:57:20 volumio volumiobt[1944]: Applying permissions
Jan 28 19:57:20 volumio volumiobt[1944]: Setting BT discoverable and pairable
Jan 28 19:57:20 volumio pulseaudio[2011]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files
Jan 28 19:57:20 volumio kernel: Bluetooth: RFCOMM TTY layer initialized
Jan 28 19:57:20 volumio kernel: Bluetooth: RFCOMM socket layer initialized
Jan 28 19:57:20 volumio kernel: Bluetooth: RFCOMM ver 1.11
Jan 28 19:57:20 volumio volumiobt[1944]: [96B blob data]
Jan 28 19:57:20 volumio volumiobt[1944]: [77B blob data]
Jan 28 19:57:20 volumio volumiobt[1944]: [77B blob data]
Jan 28 19:57:20 volumio volumiobt[1944]: [33B blob data]
Jan 28 19:57:20 volumio volumiobt[1944]: [bluetoothctl]> -e power on
Jan 28 19:57:20 volumio volumiobt[1944]: Invalid command in menu main: -e
Jan 28 19:57:20 volumio volumiobt[1944]:
Jan 28 19:57:20 volumio volumiobt[1944]: Use "help" for a list of available commands in a menu.
Jan 28 19:57:20 volumio volumiobt[1944]: Use "menu " if you want to enter any submenu.
Jan 28 19:57:20 volumio volumiobt[1944]: Use "back" if you want to return to menu main.
Jan 28 19:57:20 volumio volumiobt[1944]: [bluetoothctl]> agent on
Jan 28 19:57:20 volumio volumiobt[1944]: Agent is already registered
Jan 28 19:57:20 volumio volumiobt[1944]: [bluetoothctl]> discoverable on
Jan 28 19:57:20 volumio volumiobt[1944]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended
Jan 28 19:57:20 volumio volumiobt[1944]: [bluetoothctl]> pairable on
Jan 28 19:57:20 volumio volumiobt[1944]: [bluetoothctl]> agent NoInputNoOutput
Jan 28 19:57:20 volumio volumiobt[1944]: Agent is already registered
Jan 28 19:57:20 volumio volumiobt[1944]: [bluetoothctl]> default-agent
Jan 28 19:57:20 volumio volumiobt[1944]: [bluetoothctl]> quit
Jan 28 19:57:20 volumio volumiobt[1944]: [65B blob data]
Jan 28 19:57:21 volumio volumio[1041]: info: TidalConnect service started!
Jan 28 19:57:21 volumio volumio[1041]: [Metrics] CommandRouter: 26s 813.87ms
Jan 28 19:57:21 volumio volumio[1041]: info: CoreCommandRouter::volumiosetStartupVolume
Jan 28 19:57:21 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:21 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:21 volumio volumio[1041]: info: CoreCommandRouter::Close All Modals sent
Jan 28 19:57:21 volumio volumio[1041]: info: CoreCommandRouter::Close All Modals sent
Jan 28 19:57:22 volumio volumio[1041]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 28 19:57:22 volumio volumio[1041]: No protocol specified
Jan 28 19:57:22 volumio volumio[1041]: xcb_connection_has_error() returned true
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jan 28 19:57:22 volumio volumio[1041]: info: Version has changed, forcing UI Reload
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::Reload Ui
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:22 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 19:57:22 volumio volumio[1041]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jan 28 19:57:22 volumio volumio[1041]: info: Received Get System Info
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 19:57:22 volumio volumio[1041]: info: Discovery: Getting this device information
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:22 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:22 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:22 volumio volumio[1041]: info: Listing playlists
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 28 19:57:22 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 19:57:23 volumio volumio[1041]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:23 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 19:57:23 volumio volumio[1041]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jan 28 19:57:23 volumio volumio[1041]: info: Received Get System Info
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 19:57:23 volumio volumio[1041]: info: Discovery: Getting this device information
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:23 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:23 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:23 volumio volumio[1041]: info: Listing playlists
Jan 28 19:57:23 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 19:57:23 volumio volumio[1041]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:24 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 28 19:57:24 volumio volumio[1041]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jan 28 19:57:24 volumio volumio[1041]: info: Received Get System Info
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 19:57:24 volumio volumio[1041]: info: Discovery: Getting this device information
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:24 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:24 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:24 volumio volumio[1041]: info: Listing playlists
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 28 19:57:24 volumio volumio[1041]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:24 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:24 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:24 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:25 volumio systemd[1]: systemd-timedated.service: Succeeded.
Jan 28 19:57:25 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 28 19:57:25 volumio volumio[1041]: info: Received Get System Info
Jan 28 19:57:25 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 19:57:25 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 19:57:25 volumio volumio[1041]: info: Discovery: Getting this device information
Jan 28 19:57:25 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:25 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:25 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 19:57:25 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jan 28 19:57:27 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 28 19:57:27 volumio volumio[1041]: info: Received Get System Info
Jan 28 19:57:27 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 19:57:27 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 19:57:27 volumio volumio[1041]: info: Discovery: Getting this device information
Jan 28 19:57:27 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:27 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:27 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 19:57:28 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 28 19:57:28 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 28 19:57:28 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 28 19:57:28 volumio volumio-remote-updater[752]: No test mode
Jan 28 19:57:28 volumio volumio-remote-updater[752]: No alpha test mode
Jan 28 19:57:28 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jan 28 19:57:28 volumio volumio[1041]: info: BOOT COMPLETED
Jan 28 19:57:28 volumio volumio[1041]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Jan 28 19:57:28 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jan 28 19:57:29 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:29 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 28 19:57:29 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jan 28 19:57:29 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jan 28 19:57:29 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jan 28 19:57:29 volumio volumio[1041]: info: CoreCommandRouter::volumioGetBrowseSources
Jan 28 19:57:29 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 28 19:57:33 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 28 19:57:42 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 28 19:57:42 volumio volumio[1041]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jan 28 19:57:42 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jan 28 19:57:42 volumio volumio[1041]: info: Received Get System Version
Jan 28 19:57:42 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 28 19:57:42 volumio volumio[1041]: info: Received Get System Info
Jan 28 19:57:42 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 28 19:57:42 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 28 19:57:42 volumio volumio[1041]: info: Discovery: Getting this device information
Jan 28 19:57:42 volumio volumio[1041]: info: CoreCommandRouter::volumioGetState
Jan 28 19:57:42 volumio volumio[1041]: info: CorePlayQueue::getTrack 0
Jan 28 19:57:42 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 28 19:57:55 volumio volumio[1041]: info: CoreCommandRouter::volumioGetQueue
Jan 28 19:57:55 volumio volumio[1041]: info: CoreStateMachine::getQueue
Jan 28 19:57:55 volumio volumio[1041]: info: CorePlayQueue::getQueue
Jan 28 19:57:57 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jan 28 19:57:57 volumio volumio[1041]: info: handleBrowseUri took 100 milliseconds
Jan 28 19:57:57 volumio volumio[1041]: info: Preload queue cleared
Jan 28 19:57:57 volumio volumio[1041]: info: Preload queue cleared
Jan 28 19:58:06 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jan 28 19:58:06 volumio volumio[1041]: info: handleBrowseUri took 319 milliseconds
Jan 28 19:58:06 volumio volumio[1041]: info: Preload queue cleared
Jan 28 19:58:09 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jan 28 19:58:09 volumio volumio[1041]: info: handleBrowseUri took 183 milliseconds
Jan 28 19:58:09 volumio volumio[1041]: info: Preload queue cleared
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425879
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425880
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425881
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425882
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425883
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425884
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425885
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425886
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425887
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425888
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425889
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425890
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425891
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425892
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425893
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425894
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425895
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425896
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425897
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425898
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425899
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425900
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425901
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425902
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425903
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425904
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425905
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425906
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425907
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425908
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425909
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425910
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425911
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425912
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425913
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425914
Jan 28 19:58:09 volumio volumio[1041]: info: Preloading song: qobuz://song/62425915
Jan 28 19:58:09 volumio volumio[1041]: info: Exploding uri qobuz://song/62425879 in service qobuz
Jan 28 19:58:09 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425880 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425881 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Executing endpoint getSimilarAlbums
Jan 28 19:58:10 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425882 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425883 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Executing endpoint metavolumio
Jan 28 19:58:10 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 229 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Executing endpoint metavolumio
Jan 28 19:58:10 volumio volumio[1041]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425884 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425885 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425886 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 308 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 272 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425887 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 294 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425888 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 279 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425889 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 298 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425890 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 267 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 241 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425891 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425892 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 282 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425893 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425894 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 309 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425895 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 309 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 229 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 280 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425896 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 251 milliseconds
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425897 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425898 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: Exploding uri qobuz://song/62425899 in service qobuz
Jan 28 19:58:10 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:10 volumio volumio[1041]: info: explodeUri took 304 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 280 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 239 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425900 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 237 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425901 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 225 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425902 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425903 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 220 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 280 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425904 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425905 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 264 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 225 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425906 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 249 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425907 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 200 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 250 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425908 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425909 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425910 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 255 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 234 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425911 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425912 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425913 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 284 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425914 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 360 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: Exploding uri qobuz://song/62425915 in service qobuz
Jan 28 19:58:11 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 361 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 284 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 336 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 282 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 242 milliseconds
Jan 28 19:58:11 volumio volumio[1041]: info: explodeUri took 210 milliseconds
Jan 28 19:58:12 volumio volumio[1041]: info: explodeUri took 321 milliseconds
Jan 28 19:58:14 volumio volumio[1041]: info: Preload queue cleared
Jan 28 19:58:14 volumio volumio[1041]: info: CoreCommandRouter::volumioAddQueueItems
Jan 28 19:58:14 volumio volumio[1041]: info: CoreStateMachine::addQueueItems
Jan 28 19:58:14 volumio volumio[1041]: info: CorePlayQueue::addQueueItems
Jan 28 19:58:14 volumio volumio[1041]: info: Preload queue cleared
Jan 28 19:58:14 volumio volumio[1041]: info: Adding Item to queue: qobuz://album/jwpil7r4jg9cc
Jan 28 19:58:14 volumio volumio[1041]: info: Exploding uri qobuz://album/jwpil7r4jg9cc in service qobuz
Jan 28 19:58:14 volumio volumio[1041]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 28 19:58:21 volumio volumio[1041]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 28 19:58:21 volumio volumio[1041]: Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net
Jan 28 19:58:21 volumio volumio[1041]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
Jan 28 19:58:21 volumio volumio[1041]: errno: -3007,
Jan 28 19:58:21 volumio volumio[1041]: code: 'ENOTFOUND',
Jan 28 19:58:21 volumio volumio[1041]: syscall: 'getaddrinfo',
Jan 28 19:58:21 volumio volumio[1041]: hostname: 'lastfm.freetls.fastly.net'
Jan 28 19:58:21 volumio volumio[1041]: }
Jan 28 19:58:21 volumio volumio[1041]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 28 19:58:22 volumio sudo[2402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 19:57
Jan 28 19:58:22 volumio sudo[2402]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:18:30 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="33f9369b544b4488ff4979d2ee3813a5"