-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2026-01-12 01:41:29 UTC. -- Jan 12 01:40:05 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 12 01:40:05 screen-volumio volumio[1014]: info: Received Get System Info Jan 12 01:40:05 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:40:05 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:40:05 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:40:05 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:40:05 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:40:29 screen-volumio systemd[1]: Starting Cleanup of Temporary Directories... Jan 12 01:40:29 screen-volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Jan 12 01:40:29 screen-volumio systemd[1]: Started Cleanup of Temporary Directories. Jan 12 01:40:33 screen-volumio volumiologrotate[463]: ls: cannot access '/var/log/samba/log.wb-SCREEN': No such file or directory Jan 12 01:40:33 screen-volumio volumiologrotate[463]: ls: cannot access 'VOLUMIO': No such file or directory Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:40:54 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:40:54 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.188:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:40:54 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:40:54 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.146:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:40:54 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:05 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 12 01:41:05 screen-volumio volumio[1014]: info: Received Get System Info Jan 12 01:41:05 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:05 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:05 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:05 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:05 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:05 screen-volumio volumio[1014]: info: MyVolumio Plan changed: premium Jan 12 01:41:05 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jan 12 01:41:05 screen-volumio volumio[1014]: info: Removing browser output: myVolumio user plan is not superstar Jan 12 01:41:05 screen-volumio volumio[1014]: info: Removing audio output: Jan 12 01:41:05 screen-volumio volumio[1014]: info: MYVOLUMIO: Adding device Jan 12 01:41:05 screen-volumio volumio[1014]: info: MYVOLUMIO: Evaluating Server Jan 12 01:41:05 screen-volumio volumio[1014]: info: Remote config written successfully Jan 12 01:41:05 screen-volumio volumio[1014]: info: Starting Tunnel 1 Jan 12 01:41:05 screen-volumio volumio[1014]: info: Starting Tunnel Connection Checker Jan 12 01:41:06 screen-volumio volumio[1014]: info: MYVolumio Device disabled Jan 12 01:41:06 screen-volumio volumio[1014]: info: Setting Geolocation for MyVolumio to eu3 Jan 12 01:41:06 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:06 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:06 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:07 screen-volumio volumio[1014]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jan 12 01:41:08 screen-volumio volumio[1014]: info: Updating MyVolumio device info Jan 12 01:41:08 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:08 screen-volumio volumio[1014]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jan 12 01:41:09 screen-volumio sudo[7292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 01:41:09 screen-volumio sudo[7292]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:09 screen-volumio sudo[7292]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:09 screen-volumio sudo[7295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 01:41:09 screen-volumio sudo[7295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:09 screen-volumio sudo[7295]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:09 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.188 from 192.168.5.227 UA: Mozilla/5.0 (Linux; Android 16; SM-S908B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.146 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jan 12 01:41:09 screen-volumio volumio[1014]: info: Received Get System Info Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:09 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 01:41:09 screen-volumio volumio[1014]: info: Received Get System Info Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:09 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:09 screen-volumio volumio[1014]: info: Listing playlists Jan 12 01:41:09 screen-volumio volumio[1014]: info: Received Get System Info Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:09 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:09 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 01:41:11 screen-volumio sudo[7302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 12 01:41:11 screen-volumio sudo[7302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:11 screen-volumio systemd[1]: Started MyVolumio SSH Tunnel. Jan 12 01:41:11 screen-volumio sudo[7302]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:11 screen-volumio volumio[1014]: info: Remote SSH Started Jan 12 01:41:11 screen-volumio autossh[7305]: port set to 0, monitoring disabled Jan 12 01:41:11 screen-volumio autossh[7305]: starting ssh (count 1) Jan 12 01:41:11 screen-volumio autossh[7305]: ssh child pid is 7308 Jan 12 01:41:11 screen-volumio volumiossh-tunnel[7304]: Warning: Permanently added '[eu3.myvolumio.org]:2222,[167.71.136.233]:2222' (RSA) to the list of known hosts. Jan 12 01:41:11 screen-volumio volumio[1014]: info: MYVOLUMIO: Adding device Jan 12 01:41:11 screen-volumio volumio[1014]: info: MYVOLUMIO: Evaluating Server Jan 12 01:41:11 screen-volumio volumio[1014]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jan 12 01:41:11 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:11 screen-volumio volumio[1014]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.uRWx4Dc35GeqcTRlxyyG9lVEmwv1.92324e8cb5dad6b59525ce858f54abfc.state.track' Jan 12 01:41:13 screen-volumio volumio[1014]: info: Setting Geolocation for MyVolumio to eu3 Jan 12 01:41:13 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:13 screen-volumio volumio[1014]: info: MYVolumio Device enabled Jan 12 01:41:13 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jan 12 01:41:13 screen-volumio volumio[1014]: info: MyVolumio status changed Jan 12 01:41:13 screen-volumio volumio[1014]: info: Streaming services startup Jan 12 01:41:13 screen-volumio volumio[1014]: info: Starting Streaming Daemon Jan 12 01:41:13 screen-volumio sudo[7331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 12 01:41:13 screen-volumio volumio[1014]: info: Successfully Added MyVolumio device Jan 12 01:41:13 screen-volumio sudo[7331]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:13 screen-volumio volumio[1014]: error: [MyVolumio PluginManager] Could not read cache file: ENOENT: no such file or directory, open '/data/myvolumio/cache.data' Jan 12 01:41:13 screen-volumio sudo[7331]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:13 screen-volumio volumio[1014]: error: Cannot start Volumio Streaming Daemon Jan 12 01:41:13 screen-volumio volumio[1014]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 12 01:41:13 screen-volumio volumio[1014]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 12 01:41:14 screen-volumio volumio[1014]: info: Updating MyVolumio device info Jan 12 01:41:14 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:14 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jan 12 01:41:14 screen-volumio volumio[1014]: info: [1768182074919] Starting BluetoothController Jan 12 01:41:15 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jan 12 01:41:18 screen-volumio sudo[7348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jan 12 01:41:18 screen-volumio sudo[7348]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:18 screen-volumio sudo[7348]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:19 screen-volumio volumio[1014]: info: MRS: MultiRoom plugin initialized Jan 12 01:41:19 screen-volumio volumio[1014]: info: MRS: STOPPING SNAPCLIENT Jan 12 01:41:19 screen-volumio volumio[1014]: info: MRS: Snap server stop Jan 12 01:41:19 screen-volumio sudo[7364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jan 12 01:41:19 screen-volumio sudo[7364]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:19 screen-volumio volumio[1014]: info: MRS: STOPPING volumioStreaming Jan 12 01:41:19 screen-volumio sudo[7367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jan 12 01:41:19 screen-volumio sudo[7367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:19 screen-volumio sudo[7364]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:19 screen-volumio sudo[7370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jan 12 01:41:19 screen-volumio sudo[7370]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jan 12 01:41:19 screen-volumio sudo[7367]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:19 screen-volumio sudo[7373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jan 12 01:41:19 screen-volumio sudo[7373]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:19 screen-volumio sudo[7373]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:19 screen-volumio sudo[7370]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jan 12 01:41:19 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jan 12 01:41:20 screen-volumio volumio[1014]: info: Preparing to generate the ALSA configuration file Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 12 01:41:20 screen-volumio volumio[1014]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 12 01:41:20 screen-volumio volumio[1014]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Jan 12 01:41:20 screen-volumio volumio[1014]: info: Reading ALSA contributions from plugins. Jan 12 01:41:20 screen-volumio volumio[1014]: info: Successfully Updated MyVolumio device Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 12 01:41:20 screen-volumio volumio[1014]: info: MRS: Removed streaming files Jan 12 01:41:20 screen-volumio volumio[1014]: info: MRS: volumioStreaming STOPPED Jan 12 01:41:20 screen-volumio volumio[1014]: info: MRS: SNAPSERVER STOPPED Jan 12 01:41:20 screen-volumio volumio[1014]: info: MRS: SNAPCLIENT STOPPED Jan 12 01:41:20 screen-volumio volumio[1014]: info: Asound.conf file unchanged, so no further update is needed Jan 12 01:41:20 screen-volumio volumio[1014]: info: Output device has changed, restarting MPD Jan 12 01:41:20 screen-volumio sudo[7376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 12 01:41:20 screen-volumio sudo[7376]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:20 screen-volumio volumio[1014]: info: Output device has changed, restarting Shairport Sync Jan 12 01:41:20 screen-volumio sudo[7376]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:20 screen-volumio sudo[7379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 12 01:41:20 screen-volumio sudo[7379]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:20 screen-volumio systemd[1]: Stopping Music Player Daemon... Jan 12 01:41:20 screen-volumio volumio[1014]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 12 01:41:20 screen-volumio volumio[1014]: [SpotifyConnect] Creating VLS config file Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:20 screen-volumio volumio[1014]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:20 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 12 01:41:20 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jan 12 01:41:20 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output for this device Jan 12 01:41:20 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding audio output: Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding audio output: Jan 12 01:41:20 screen-volumio sudo[7390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Screen Volumio Jan 12 01:41:20 screen-volumio sudo[7390]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:20 screen-volumio sudo[7390]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:20 screen-volumio volumio[1014]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:20 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding METAVOLUMIO REST API Endpoints Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jan 12 01:41:20 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jan 12 01:41:20 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jan 12 01:41:20 screen-volumio volumio[1014]: info: Preparing CD Folders Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding CD REST API Endpoints Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jan 12 01:41:20 screen-volumio volumio[1014]: info: Starting UDEV Watcher for CD Jan 12 01:41:20 screen-volumio volumio[1014]: info: Detecting CD presence with UDEV Jan 12 01:41:20 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jan 12 01:41:20 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding inputs REST Endpoints Jan 12 01:41:20 screen-volumio volumio[1014]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jan 12 01:41:20 screen-volumio volumio[1014]: info: Scanning Audio Inputs Jan 12 01:41:21 screen-volumio volumio[1014]: info: Checking against Known Cards name Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding Server instance for streaming Jan 12 01:41:21 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jan 12 01:41:21 screen-volumio volumio[1014]: error: Hi Res Audio Failed Login: Missing Login Data Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding HIGHRESAUDIO REST API Endpoints Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 12 01:41:21 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jan 12 01:41:21 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jan 12 01:41:21 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jan 12 01:41:21 screen-volumio volumio[1014]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Jan 12 01:41:21 screen-volumio sudo[7398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 12 01:41:21 screen-volumio sudo[7398]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:21 screen-volumio volumio[1014]: info: QobuzConnect: Starting Qobuz Connect socket and service Jan 12 01:41:21 screen-volumio sudo[7404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 12 01:41:21 screen-volumio sudo[7398]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:21 screen-volumio sudo[7404]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:21 screen-volumio volumio[1014]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding TIDAL REST API Endpoints Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jan 12 01:41:21 screen-volumio volumio[1014]: info: Stopping AccessToken refresher cron for QOBUZ Jan 12 01:41:21 screen-volumio sudo[7404]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:21 screen-volumio sudo[7407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 12 01:41:21 screen-volumio sudo[7407]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:21 screen-volumio volumio[1014]: info: AccessToken refresher cron started for QOBUZ Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding QOBUZ REST API Endpoints Jan 12 01:41:21 screen-volumio volumio[1014]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jan 12 01:41:21 screen-volumio volumio[1014]: [SpotifyConnect] Restarting Vollibrespot Daemon Jan 12 01:41:21 screen-volumio sudo[7410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Jan 12 01:41:21 screen-volumio volumio[1014]: info: Bluetooth name changed to Screen Volumio Jan 12 01:41:21 screen-volumio volumio[1014]: info: MPD Permissions set Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::servicePushState Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreStateMachine::pushState Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Jan 12 01:41:21 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output update for this device Jan 12 01:41:21 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::servicePushState Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreStateMachine::pushState Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Jan 12 01:41:21 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output update for this device Jan 12 01:41:21 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:21 screen-volumio systemd[1]: Started Volumio Qobuz Connect Service. Jan 12 01:41:21 screen-volumio sudo[7410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:21 screen-volumio sudo[7407]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:21 screen-volumio systemd[1]: Started Volspotconnect2 Daemon. Jan 12 01:41:21 screen-volumio volumio[1014]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.uRWx4Dc35GeqcTRlxyyG9lVEmwv1.92324e8cb5dad6b59525ce858f54abfc.state.track' Jan 12 01:41:21 screen-volumio sudo[7410]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:21 screen-volumio volumio[1014]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.uRWx4Dc35GeqcTRlxyyG9lVEmwv1.92324e8cb5dad6b59525ce858f54abfc.state.track' Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:21 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:21 screen-volumio volumio[1014]: [SpotifyConnect] Vollibrespot Daemon service restarted! Jan 12 01:41:22 screen-volumio volumio[1014]: info: Starting Shairport Sync Jan 12 01:41:22 screen-volumio volumio[7414]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jan 12 01:41:22 screen-volumio volumio[7414]: Reading Config from "/tmp/volspotify.toml" Jan 12 01:41:22 screen-volumio volumio[1014]: info: MRS: Found cast device: Google-Cast-Group-088d29d6efda4fe8bb72cbe26e873a12 Jan 12 01:41:22 screen-volumio volumio[1014]: info: Adding audio output: Jan 12 01:41:22 screen-volumio volumio[1014]: info: Preparing to generate the ALSA configuration file Jan 12 01:41:22 screen-volumio volumio[7414]: [Vollibrespot] : Using Alsa backend with device: volumio Jan 12 01:41:22 screen-volumio sudo[7425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 12 01:41:22 screen-volumio sudo[7425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:22 screen-volumio volumio[1014]: info: MRS: Found cast device: Mi-Smart-Speaker-Lit-5ac8f971827fc7263b8429616c0b8c63 Jan 12 01:41:22 screen-volumio volumio[1014]: info: Adding audio output: Jan 12 01:41:22 screen-volumio volumio[1014]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 12 01:41:22 screen-volumio volumio[1014]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Jan 12 01:41:22 screen-volumio volumio[1014]: info: Reading ALSA contributions from plugins. Jan 12 01:41:22 screen-volumio volumio[1014]: info: MRS: Found cast device: Google-Cast-Group-088d29d6efda4fe8bb72cbe26e873a12 Jan 12 01:41:22 screen-volumio volumio[1014]: info: Asound.conf file unchanged, so no further update is needed Jan 12 01:41:22 screen-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 12 01:41:22 screen-volumio volumio[1014]: info: Output device has changed, restarting MPD Jan 12 01:41:22 screen-volumio systemd[1]: shairport-sync.service: Succeeded. Jan 12 01:41:22 screen-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 12 01:41:22 screen-volumio volumio[1014]: info: Output device has changed, restarting Shairport Sync Jan 12 01:41:22 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:22 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:22 screen-volumio sudo[7428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 12 01:41:22 screen-volumio sudo[7428]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:22 screen-volumio volumio[7414]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jan 12 01:41:22 screen-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 12 01:41:22 screen-volumio sudo[7431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 12 01:41:22 screen-volumio sudo[7425]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:22 screen-volumio sudo[7428]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:22 screen-volumio sudo[7431]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:22 screen-volumio volumio[1014]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 12 01:41:22 screen-volumio volumio[1014]: [SpotifyConnect] Creating VLS config file Jan 12 01:41:22 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:22 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:22 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:22 screen-volumio volumio[1014]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 12 01:41:22 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:22 screen-volumio volumio[1014]: info: QobuzConnect: setDeactiveState invoked Jan 12 01:41:22 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:22 screen-volumio volumio[1014]: info: Preparing to generate the ALSA configuration file Jan 12 01:41:22 screen-volumio volumio[1014]: [SpotifyConnect] Restarting Vollibrespot Daemon Jan 12 01:41:22 screen-volumio sudo[7444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Jan 12 01:41:22 screen-volumio sudo[7444]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:22 screen-volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jan 12 01:41:22 screen-volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Jan 12 01:41:22 screen-volumio systemd[1]: volspotconnect.service: Succeeded. Jan 12 01:41:22 screen-volumio systemd[1]: Stopped Volspotconnect2 Daemon. Jan 12 01:41:22 screen-volumio volumio[1014]: info: MRS: Found cast device: Mi-Smart-Speaker-Lit-5ac8f971827fc7263b8429616c0b8c63 Jan 12 01:41:22 screen-volumio volumio[1014]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 12 01:41:22 screen-volumio volumio[1014]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 12 01:41:22 screen-volumio volumio[1014]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Jan 12 01:41:22 screen-volumio volumio[1014]: info: Reading ALSA contributions from plugins. Jan 12 01:41:22 screen-volumio sudo[7451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 12 01:41:22 screen-volumio sudo[7451]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:22 screen-volumio systemd[1]: Started Volspotconnect2 Daemon. Jan 12 01:41:22 screen-volumio volumio[1014]: info: MPD Permissions set Jan 12 01:41:22 screen-volumio volumio[1014]: info: Shairport-Sync Started Jan 12 01:41:22 screen-volumio volumio[1014]: info: Executing endpoint qc_getconfig Jan 12 01:41:22 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 12 01:41:22 screen-volumio volumio[7450]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jan 12 01:41:22 screen-volumio volumio[7450]: Reading Config from "/tmp/volspotify.toml" Jan 12 01:41:22 screen-volumio volumio[7450]: [Vollibrespot] : Using Alsa backend with device: volumio Jan 12 01:41:22 screen-volumio sudo[7444]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:22 screen-volumio sudo[7451]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:23 screen-volumio sudo[7459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 12 01:41:23 screen-volumio sudo[7459]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:23 screen-volumio qobuz-connect[7411]: 20260112 01:41:23.073 [7411.7411] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:23 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:23 screen-volumio volumio[7450]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jan 12 01:41:23 screen-volumio volumio[1014]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 12 01:41:23 screen-volumio volumio[1014]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 12 01:41:23 screen-volumio volumio[1014]: [SpotifyConnect] Vollibrespot Daemon service restarted! Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Jan 12 01:41:23 screen-volumio systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT Jan 12 01:41:23 screen-volumio systemd[1]: qobuz-connect.service: Succeeded. Jan 12 01:41:23 screen-volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:23 screen-volumio systemd[1]: Started Volumio Qobuz Connect Service. Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 12 01:41:23 screen-volumio sudo[7459]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:23 screen-volumio volumio[1014]: info: QobuzConnect: setDeactiveState invoked Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:23 screen-volumio volumio[1014]: info: Starting Shairport Sync Jan 12 01:41:23 screen-volumio volumio[1014]: info: Executing endpoint qc_getconfig Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 12 01:41:23 screen-volumio sudo[7468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 12 01:41:23 screen-volumio sudo[7468]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:23 screen-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.363 [7461.7461] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 12 01:41:23 screen-volumio systemd[1]: shairport-sync.service: Succeeded. Jan 12 01:41:23 screen-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 12 01:41:23 screen-volumio volumio[1014]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 12 01:41:23 screen-volumio volumio[1014]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 12 01:41:23 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.188:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jan 12 01:41:23 screen-volumio volumio[1014]: info: Asound.conf file written Jan 12 01:41:23 screen-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 12 01:41:23 screen-volumio sudo[7468]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:23 screen-volumio sudo[7474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 12 01:41:23 screen-volumio sudo[7474]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:23 screen-volumio sudo[7474]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.706 [7461.7461] INFO VolumeManager: [0x7812d8]: Setting new playback volume: 75 Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.706 [7461.7461] INFO VolumeManager: [0x7812d8]: Setting new mute state: 0 Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.707 [7461.7461] INFO QobuzConnect: [0x781ca8]: Client initialized! Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.707 [7461.7461] INFO SampleApp: Starting Avahi advertising, name: Screen Volumio, service name: _qobuz-connect._tcp Jan 12 01:41:23 screen-volumio volumio[1014]: info: Output device has changed, restarting MPD Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.728 [7461.7461] INFO LocalConfigManager: [0x780bb8]: Starting Local Configuration server Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.728 [7461.7461] INFO SampleApp: Starting Local configuration server Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.729 [7461.7461] INFO SampleApp: Playback volume changed: 75 Jan 12 01:41:23 screen-volumio qobuz-connect[7461]: 20260112 01:41:23.730 [7461.7461] INFO SampleApp: Connected to UNIX socket client 0x776f60 Jan 12 01:41:23 screen-volumio sudo[7482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 12 01:41:23 screen-volumio sudo[7482]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:23 screen-volumio sudo[7482]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:23 screen-volumio volumio[1014]: info: Output device has changed, restarting Shairport Sync Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:23 screen-volumio sudo[7485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 12 01:41:23 screen-volumio sudo[7485]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:23 screen-volumio volumio[1014]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 12 01:41:23 screen-volumio volumio[1014]: [SpotifyConnect] Creating VLS config file Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio volumio[1014]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 12 01:41:23 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:23 screen-volumio systemd[1]: mpd.service: Succeeded. Jan 12 01:41:24 screen-volumio systemd[1]: Stopped Music Player Daemon. Jan 12 01:41:24 screen-volumio volumio[1014]: info: QobuzConnect: setDeactiveState invoked Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:24 screen-volumio volumio[1014]: [SpotifyConnect] Restarting Vollibrespot Daemon Jan 12 01:41:24 screen-volumio systemd[1]: Starting Music Player Daemon... Jan 12 01:41:24 screen-volumio sudo[7494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Jan 12 01:41:24 screen-volumio sudo[7494]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:24 screen-volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jan 12 01:41:24 screen-volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Jan 12 01:41:24 screen-volumio systemd[1]: volspotconnect.service: Succeeded. Jan 12 01:41:24 screen-volumio systemd[1]: Stopped Volspotconnect2 Daemon. Jan 12 01:41:24 screen-volumio systemd[1]: Started Volspotconnect2 Daemon. Jan 12 01:41:24 screen-volumio sudo[7500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 12 01:41:24 screen-volumio sudo[7500]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:24 screen-volumio sudo[7494]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:24 screen-volumio volumio[7501]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jan 12 01:41:24 screen-volumio volumio[7501]: Reading Config from "/tmp/volspotify.toml" Jan 12 01:41:24 screen-volumio volumio[7501]: Malformed config key: missing field `Authentication` Jan 12 01:41:24 screen-volumio systemd[1]: volspotconnect.service: Main process exited, code=exited, status=1/FAILURE Jan 12 01:41:24 screen-volumio systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:24 screen-volumio sudo[7505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jan 12 01:41:24 screen-volumio sudo[7505]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:24 screen-volumio volumio[1014]: [SpotifyConnect] Vollibrespot Daemon service restarted! Jan 12 01:41:24 screen-volumio volumio[1014]: info: MPD Permissions set Jan 12 01:41:24 screen-volumio volumio[1014]: info: Shairport-Sync Started Jan 12 01:41:24 screen-volumio sudo[7500]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:24 screen-volumio sudo[7492]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 12 01:41:24 screen-volumio sudo[7492]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:24 screen-volumio sudo[7492]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:24 screen-volumio sudo[7507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 12 01:41:24 screen-volumio sudo[7507]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:24 screen-volumio systemd[1]: Started Volumio Bluetooth Module. Jan 12 01:41:24 screen-volumio sudo[7505]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:24 screen-volumio sudo[7511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jan 12 01:41:24 screen-volumio sudo[7511]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:24 screen-volumio volumiobt[7509]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jan 12 01:41:24 screen-volumio sudo[7511]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:24 screen-volumio qobuz-connect[7461]: 20260112 01:41:24.582 [7461.7461] INFO SampleApp: Stopping Local configuration server Jan 12 01:41:24 screen-volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Jan 12 01:41:24 screen-volumio qobuz-connect[7461]: 20260112 01:41:24.593 [7461.7461] INFO SampleApp: shat down connection on UNIX socket Jan 12 01:41:24 screen-volumio systemd[1]: qobuz-connect.service: Succeeded. Jan 12 01:41:24 screen-volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 01:41:24 screen-volumio systemd[1]: Started Volumio Qobuz Connect Service. Jan 12 01:41:24 screen-volumio sudo[7507]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:24 screen-volumio volumio[1014]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 01:41:24 screen-volumio volumio[1014]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 01:41:24 screen-volumio volumio[1014]: info: Executing endpoint metavolumio Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 12 01:41:24 screen-volumio volumio[1014]: info: TidalConnect service stoped! Jan 12 01:41:24 screen-volumio volumio[1014]: info: Volumio BT Module successfully started Jan 12 01:41:24 screen-volumio volumio[1014]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 12 01:41:24 screen-volumio volumio[1014]: info: QobuzConnect: setDeactiveState invoked Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:24 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:24 screen-volumio volumio[1014]: info: Executing endpoint qc_getconfig Jan 12 01:41:24 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 12 01:41:24 screen-volumio qobuz-connect[7519]: 20260112 01:41:24.953 [7519.7519] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 12 01:41:24 screen-volumio qobuz-connect[7519]: 20260112 01:41:24.970 [7519.7519] INFO VolumeManager: [0x233f2d8]: Setting new playback volume: 75 Jan 12 01:41:24 screen-volumio qobuz-connect[7519]: 20260112 01:41:24.970 [7519.7519] INFO VolumeManager: [0x233f2d8]: Setting new mute state: 0 Jan 12 01:41:24 screen-volumio qobuz-connect[7519]: 20260112 01:41:24.970 [7519.7519] INFO QobuzConnect: [0x233fca8]: Client initialized! Jan 12 01:41:24 screen-volumio qobuz-connect[7519]: 20260112 01:41:24.970 [7519.7519] INFO SampleApp: Starting Avahi advertising, name: Screen Volumio, service name: _qobuz-connect._tcp Jan 12 01:41:24 screen-volumio qobuz-connect[7519]: 20260112 01:41:24.996 [7519.7519] INFO LocalConfigManager: [0x233ebb8]: Starting Local Configuration server Jan 12 01:41:24 screen-volumio qobuz-connect[7519]: 20260112 01:41:24.996 [7519.7519] INFO SampleApp: Starting Local configuration server Jan 12 01:41:24 screen-volumio qobuz-connect[7519]: 20260112 01:41:24.997 [7519.7519] INFO SampleApp: Connected to UNIX socket client 0x2334f60 Jan 12 01:41:25 screen-volumio volumio[1014]: info: Starting Shairport Sync Jan 12 01:41:25 screen-volumio volumio[1014]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 12 01:41:25 screen-volumio volumio[1014]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 12 01:41:25 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.146:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jan 12 01:41:25 screen-volumio qobuz-connect[7519]: 20260112 01:41:25.104 [7519.7519] INFO SampleApp: Playback volume changed: 75 Jan 12 01:41:25 screen-volumio volumio[1014]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 12 01:41:25 screen-volumio sudo[7533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 12 01:41:25 screen-volumio volumio[1014]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 12 01:41:25 screen-volumio sudo[7533]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:25 screen-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 12 01:41:25 screen-volumio systemd[1]: shairport-sync.service: Succeeded. Jan 12 01:41:25 screen-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:25 screen-volumio sudo[7536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 12 01:41:25 screen-volumio sudo[7536]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:25 screen-volumio volumio[1014]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 01:41:25 screen-volumio volumio[1014]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:25 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:25 screen-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 12 01:41:25 screen-volumio sudo[7533]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:25 screen-volumio volumio[1014]: info: Shairport-Sync Started Jan 12 01:41:25 screen-volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 12 01:41:25 screen-volumio sudo[7536]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:25 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.188:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:25 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:25 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:25 screen-volumio sudo[7559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jan 12 01:41:25 screen-volumio sudo[7559]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 01:41:25 screen-volumio volumiobt[7509]: pulseaudio: no process found Jan 12 01:41:25 screen-volumio sudo[7559]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:25 screen-volumio volumio[1014]: info: MRS: Getting audio outputs on start Jan 12 01:41:25 screen-volumio volumio[1014]: info: MRS: Requesting all other devices output Jan 12 01:41:25 screen-volumio dbus-daemon[472]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.40' (uid=1000 pid=7563 comm="/usr/bin/pulseaudio --high-priority=true ") Jan 12 01:41:25 screen-volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jan 12 01:41:26 screen-volumio volumio[1014]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 01:41:26 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.146:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:26 screen-volumio dbus-daemon[472]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jan 12 01:41:26 screen-volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Jan 12 01:41:26 screen-volumio rtkit-daemon[7564]: Successfully called chroot. Jan 12 01:41:26 screen-volumio rtkit-daemon[7564]: Successfully dropped privileges. Jan 12 01:41:26 screen-volumio rtkit-daemon[7564]: Successfully limited resources. Jan 12 01:41:26 screen-volumio rtkit-daemon[7564]: Running. Jan 12 01:41:26 screen-volumio rtkit-daemon[7564]: Watchdog thread running. Jan 12 01:41:26 screen-volumio rtkit-daemon[7564]: Canary thread running. Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:26 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:26 screen-volumio dbus-daemon[472]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.41' (uid=0 pid=7564 comm="/usr/lib/rtkit/rtkit-daemon ") Jan 12 01:41:26 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.188:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:26 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:26 screen-volumio systemd[1]: Starting Authorization Manager... Jan 12 01:41:26 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.146:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jan 12 01:41:26 screen-volumio volumio[1014]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:26 screen-volumio systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Jan 12 01:41:26 screen-volumio systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 1. Jan 12 01:41:26 screen-volumio systemd[1]: Stopped Volspotconnect2 Daemon. Jan 12 01:41:26 screen-volumio systemd[1]: Started Volspotconnect2 Daemon. Jan 12 01:41:26 screen-volumio volumio[7569]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jan 12 01:41:26 screen-volumio volumio[7569]: Reading Config from "/tmp/volspotify.toml" Jan 12 01:41:26 screen-volumio volumio[7569]: [Vollibrespot] : Using Alsa backend with device: volumio Jan 12 01:41:26 screen-volumio volumio[7569]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jan 12 01:41:26 screen-volumio volumio[1014]: info: Executing endpoint tc_getconfig Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 12 01:41:26 screen-volumio vtcs[7541]: STARTING TidalConnect services, version: 1.5.2.56 Jan 12 01:41:26 screen-volumio vtcs[7541]: STARTED TidalConnect services. Jan 12 01:41:26 screen-volumio polkitd[7568]: started daemon version 0.105 using authority implementation `local' version `0.105' Jan 12 01:41:26 screen-volumio dbus-daemon[472]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 12 01:41:26 screen-volumio systemd[1]: Started Authorization Manager. Jan 12 01:41:26 screen-volumio volumio[1014]: info: Executing endpoint tc_connect Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 12 01:41:26 screen-volumio volumio[1014]: info: Connecting to TidalConnect Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::servicePushState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreStateMachine::pushState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Jan 12 01:41:26 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output update for this device Jan 12 01:41:26 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Jan 12 01:41:26 screen-volumio volumio[1014]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::servicePushState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreStateMachine::pushState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioPushState Jan 12 01:41:26 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output update for this device Jan 12 01:41:26 screen-volumio volumio[1014]: info: MRS: Pushing multiroomSync output Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CorePlayQueue::getTrack 0 Jan 12 01:41:26 screen-volumio volumio[1014]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Jan 12 01:41:26 screen-volumio volumio[1014]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.uRWx4Dc35GeqcTRlxyyG9lVEmwv1.92324e8cb5dad6b59525ce858f54abfc.state.track' Jan 12 01:41:26 screen-volumio volumio[1014]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.uRWx4Dc35GeqcTRlxyyG9lVEmwv1.92324e8cb5dad6b59525ce858f54abfc.state.track' Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:26 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:26 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:27 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.188:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jan 12 01:41:27 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:41:27 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:27 screen-volumio pulseaudio[7563]: Failed to open cookie file '/home/volumio/.config/pulse/cookie': No such file or directory Jan 12 01:41:27 screen-volumio pulseaudio[7563]: Failed to load authentication key '/home/volumio/.config/pulse/cookie': No such file or directory Jan 12 01:41:27 screen-volumio pulseaudio[7563]: Failed to open cookie file '/home/volumio/.pulse-cookie': No such file or directory Jan 12 01:41:27 screen-volumio pulseaudio[7563]: Failed to load authentication key '/home/volumio/.pulse-cookie': No such file or directory Jan 12 01:41:27 screen-volumio pulseaudio[7563]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 12 01:41:27 screen-volumio pulseaudio[7563]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 12 01:41:27 screen-volumio volumiobt[7509]: Applying permissions Jan 12 01:41:27 screen-volumio volumiobt[7509]: Setting BT discoverable and pairable Jan 12 01:41:27 screen-volumio pulseaudio[7563]: 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 12 01:41:27 screen-volumio bluetoothd[767]: Endpoint registered: sender=:1.62 path=/MediaEndpoint/A2DPSource Jan 12 01:41:27 screen-volumio bluetoothd[767]: Endpoint registered: sender=:1.62 path=/MediaEndpoint/A2DPSink Jan 12 01:41:27 screen-volumio kernel: Bluetooth: RFCOMM TTY layer initialized Jan 12 01:41:27 screen-volumio kernel: Bluetooth: RFCOMM socket layer initialized Jan 12 01:41:27 screen-volumio kernel: Bluetooth: RFCOMM ver 1.11 Jan 12 01:41:27 screen-volumio volumiobt[7509]: [96B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [77B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [77B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [78B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [78B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [33B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [79B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [95B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [65B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [55B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [bluetoothctl]> -e power on Jan 12 01:41:27 screen-volumio volumiobt[7509]: Invalid command in menu main: -e Jan 12 01:41:27 screen-volumio volumiobt[7509]: Jan 12 01:41:27 screen-volumio volumiobt[7509]: Use "help" for a list of available commands in a menu. Jan 12 01:41:27 screen-volumio volumiobt[7509]: Use "menu " if you want to enter any submenu. Jan 12 01:41:27 screen-volumio volumiobt[7509]: Use "back" if you want to return to menu main. Jan 12 01:41:27 screen-volumio volumiobt[7509]: [55B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [bluetoothctl]> agent on Jan 12 01:41:27 screen-volumio volumiobt[7509]: Agent is already registered Jan 12 01:41:27 screen-volumio volumiobt[7509]: [78B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [bluetoothctl]> discoverable on Jan 12 01:41:27 screen-volumio volumiobt[7509]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Jan 12 01:41:27 screen-volumio volumiobt[7509]: [bluetoothctl]> pairable on Jan 12 01:41:27 screen-volumio volumiobt[7509]: [bluetoothctl]> agent NoInputNoOutput Jan 12 01:41:27 screen-volumio volumiobt[7509]: Agent is already registered Jan 12 01:41:27 screen-volumio volumiobt[7509]: [bluetoothctl]> default-agent Jan 12 01:41:27 screen-volumio volumiobt[7509]: [90B blob data] Jan 12 01:41:27 screen-volumio volumiobt[7509]: [bluetoothctl]> quit Jan 12 01:41:27 screen-volumio volumiobt[7509]: [65B blob data] Jan 12 01:41:27 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 01:41:27 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 01:41:27 screen-volumio volumio[1014]: info: Discovery: Getting this device information Jan 12 01:41:27 screen-volumio volumio[1014]: info: CoreCommandRouter::volumioGetState Jan 12 01:41:27 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 01:41:27 screen-volumio volumio[1014]: verbose: New Socket.io Connection to 192.168.5.146:3000 from 192.168.5.227 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jan 12 01:41:27 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 01:41:27 screen-volumio volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 01:41:28 screen-volumio volumio[1014]: info: Checking Spotify Web API Jan 12 01:41:28 screen-volumio volumio[1014]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 01:41:28 screen-volumio volumio[1014]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Jan 12 01:41:28 screen-volumio volumio[1014]: at healthCheck (dgram.js:897:11) Jan 12 01:41:28 screen-volumio volumio[1014]: at Socket.send (dgram.js:622:3) Jan 12 01:41:28 screen-volumio volumio[1014]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) Jan 12 01:41:28 screen-volumio volumio[1014]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2354:23) Jan 12 01:41:28 screen-volumio volumio[1014]: at Timeout._onTimeout (/data/plugins/music_service/spop/index.js:2694:18) Jan 12 01:41:28 screen-volumio volumio[1014]: at listOnTimeout (internal/timers.js:554:17) Jan 12 01:41:28 screen-volumio volumio[1014]: at processTimers (internal/timers.js:497:7) { Jan 12 01:41:28 screen-volumio volumio[1014]: code: 'ERR_SOCKET_DGRAM_NOT_RUNNING' Jan 12 01:41:28 screen-volumio volumio[1014]: } Jan 12 01:41:28 screen-volumio volumio[1014]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 01:41:28 screen-volumio mpd[7512]: Jan 12 01:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 12 01:41:28 screen-volumio systemd[1]: Started Music Player Daemon. Jan 12 01:41:28 screen-volumio sudo[7485]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:28 screen-volumio sudo[7431]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:28 screen-volumio sudo[7379]: pam_unix(sudo:session): session closed for user root Jan 12 01:41:29 screen-volumio sudo[7611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-12 01:40 Jan 12 01:41:29 screen-volumio sudo[7611]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"