-- Logs begin at Wed 2024-06-19 21:22:29 CEST, end at Sat 2024-07-13 07:35:00 CEST. -- Jul 13 07:34:44 streamer ntpd[760]: receive: Unexpected origin timestamp 0xea1daec5.0159938d does not match aorg 0000000000.00000000 from server@185.242.56.3 xmt 0xea3c9074.8ce74d33 Jul 13 07:34:44 streamer systemd[1]: Starting Daily man-db regeneration... Jul 13 07:34:44 streamer systemd[1]: Starting Daily apt download activities... Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 13 07:34:44 streamer volumio[860]: info: Retrieving Cloud Streaming UI Jul 13 07:34:44 streamer volumio[860]: info: Getting Tidal Cloud Configuration Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 13 07:34:44 streamer volumio[860]: info: Getting Qobuz Cloud Configuration Jul 13 07:34:44 streamer volumio[860]: info: Asking plugin for UI Config Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 13 07:34:44 streamer volumio[860]: info: Getting Spotify Cloud Configuration Jul 13 07:34:44 streamer volumio[860]: info: Asking plugin for UI Config Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 13 07:34:44 streamer volumio[860]: info: Saving Spotify Acccount Jul 13 07:34:44 streamer volumio[860]: info: Got Tidal Cloud Configuration Jul 13 07:34:44 streamer volumio[860]: info: Got it Jul 13 07:34:44 streamer volumio[860]: info: Got it Jul 13 07:34:44 streamer volumio[860]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 13 07:34:44 streamer volumio[860]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::volumioGetBrowseSources Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::volumioGetBrowseSources Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::volumioGetBrowseSources Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 07:34:44 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 13 07:34:45 streamer volumio[860]: info: Discovery: A device disappeared from network Jul 13 07:34:45 streamer volumio[860]: info: Discovery: Device streamer disappeared from network Jul 13 07:34:45 streamer volumio[860]: info: Discovery: adding 889e3732-2357-421b-b7c3-2eb5dc23fecc Jul 13 07:34:45 streamer volumio[860]: info: Discovery: Found device streamer Jul 13 07:34:45 streamer volumio[860]: info: CoreCommandRouter::volumioGetState Jul 13 07:34:45 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:45 streamer volumio[860]: info: MyVolumio login type: Token Jul 13 07:34:46 streamer volumio[860]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 13 07:34:47 streamer volumio[860]: info: MyVolumio token set successfully Jul 13 07:34:47 streamer volumio[860]: info: MYVOLUMIO: Adding device Jul 13 07:34:47 streamer volumio[860]: info: MYVOLUMIO: Evaluating Server Jul 13 07:34:47 streamer systemd[1]: man-db.service: Succeeded. Jul 13 07:34:47 streamer systemd[1]: Started Daily man-db regeneration. Jul 13 07:34:50 streamer volumio[860]: info: MyVolumio Plan changed: premium Jul 13 07:34:50 streamer volumio[860]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jul 13 07:34:50 streamer volumio[860]: info: Removing browser output: myVolumio user plan is not superstar Jul 13 07:34:50 streamer volumio[860]: info: Removing audio output: Jul 13 07:34:50 streamer volumio[860]: info: MYVOLUMIO: Adding device Jul 13 07:34:50 streamer volumio[860]: info: MYVOLUMIO: Evaluating Server Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 13 07:34:50 streamer volumio[860]: info: Remote config written successfully Jul 13 07:34:50 streamer volumio[860]: info: Starting Tunnel 1 Jul 13 07:34:50 streamer volumio[860]: info: Starting Tunnel Connection Checker Jul 13 07:34:50 streamer volumio[860]: info: Received Get System Info Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 13 07:34:50 streamer volumio[860]: info: Discovery: Getting this device information Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::volumioGetState Jul 13 07:34:50 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 13 07:34:50 streamer volumio[860]: info: MYVolumio Device enabled Jul 13 07:34:50 streamer volumio[860]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jul 13 07:34:50 streamer volumio[860]: info: MyVolumio status changed Jul 13 07:34:50 streamer volumio[860]: info: Streaming services startup Jul 13 07:34:50 streamer volumio[860]: info: Starting Streaming Daemon Jul 13 07:34:50 streamer sudo[1841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 13 07:34:50 streamer sudo[1841]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:50 streamer volumio[860]: info: Setting Geolocation for MyVolumio to eu10 Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:50 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jul 13 07:34:50 streamer sudo[1841]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:50 streamer volumio[860]: error: [MyVolumio PluginManager] Cache data is invalid! Jul 13 07:34:50 streamer volumio[860]: error: Cannot start Volumio Streaming Daemon Jul 13 07:34:50 streamer volumio[860]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 13 07:34:50 streamer volumio[860]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 13 07:34:51 streamer systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Jul 13 07:34:51 streamer systemd[1]: Reached target Host and Network Name Lookups. Jul 13 07:34:51 streamer volumio[860]: info: Setting Geolocation for MyVolumio to eu10 Jul 13 07:34:51 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:51 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:51 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:51 streamer systemd[1]: Starting Preprocess NFS configuration... Jul 13 07:34:51 streamer systemd[1]: nfs-config.service: Succeeded. Jul 13 07:34:51 streamer systemd[1]: Started Preprocess NFS configuration. Jul 13 07:34:51 streamer systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... Jul 13 07:34:51 streamer systemd[1]: Starting Notify NFS peers of a restart... Jul 13 07:34:51 streamer sm-notify[1874]: Version 1.3.3 starting Jul 13 07:34:51 streamer systemd[1]: rpc-statd-notify.service: Succeeded. Jul 13 07:34:51 streamer systemd[1]: Started Notify NFS peers of a restart. Jul 13 07:34:51 streamer systemd[1]: apt-daily.service: Succeeded. Jul 13 07:34:51 streamer systemd[1]: Started Daily apt download activities. Jul 13 07:34:51 streamer systemd[1]: Starting Daily apt upgrade and clean activities... Jul 13 07:34:51 streamer rpc.statd[1880]: Version 1.3.3 starting Jul 13 07:34:51 streamer rpc.statd[1880]: Flags: TI-RPC Jul 13 07:34:51 streamer systemd[1]: Started NFS status monitor for NFSv2/3 locking.. Jul 13 07:34:51 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 13 07:34:51 streamer volumio[860]: info: Successfully Added MyVolumio device Jul 13 07:34:51 streamer volumio[860]: info: Successfully Added MyVolumio device Jul 13 07:34:51 streamer volumio[860]: info: Updating MyVolumio device info Jul 13 07:34:51 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:51 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:51 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:52 streamer volumio[860]: info: Successfully Updated MyVolumio device Jul 13 07:34:52 streamer volumio[860]: info: Updating MyVolumio device info Jul 13 07:34:52 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:52 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:52 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:52 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jul 13 07:34:52 streamer systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 13 07:34:52 streamer systemd[1]: Started Daily apt upgrade and clean activities. Jul 13 07:34:52 streamer volumio[860]: info: [1720848892585] Starting BluetoothController Jul 13 07:34:52 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jul 13 07:34:53 streamer volumio[860]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jul 13 07:34:53 streamer sudo[1957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jul 13 07:34:53 streamer sudo[1957]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:53 streamer sudo[1957]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:53 streamer volumio[860]: info: MRS: MultiRoom plugin initialized Jul 13 07:34:53 streamer volumio[860]: info: MRS: STOPPING SNAPCLIENT Jul 13 07:34:53 streamer volumio[860]: info: MRS: Snap server stop Jul 13 07:34:53 streamer sudo[1974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jul 13 07:34:53 streamer sudo[1974]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:53 streamer volumio[860]: info: MRS: STOPPING volumioStreaming Jul 13 07:34:53 streamer sudo[1981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jul 13 07:34:53 streamer sudo[1981]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:53 streamer sudo[1974]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:53 streamer sudo[1984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jul 13 07:34:53 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jul 13 07:34:53 streamer sudo[1984]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:53 streamer sudo[1981]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:53 streamer sudo[1988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 13 07:34:53 streamer sudo[1988]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:53 streamer sudo[1988]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:53 streamer sudo[1984]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:53 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jul 13 07:34:53 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jul 13 07:34:53 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jul 13 07:34:53 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jul 13 07:34:54 streamer volumio[860]: info: Preparing to generate the ALSA configuration file Jul 13 07:34:54 streamer volumio[860]: info: MyVolumio login type: Token Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jul 13 07:34:54 streamer volumio[860]: info: The plugin peppy_alsa_pipe has an ALSA contribution file peppy_in.peppy_out.6.conf Jul 13 07:34:54 streamer volumio[860]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 13 07:34:54 streamer volumio[860]: info: Reading ALSA contributions from plugins. Jul 13 07:34:54 streamer volumio[860]: info: Successfully Updated MyVolumio device Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 13 07:34:54 streamer volumio[860]: info: MRS: Removed streaming files Jul 13 07:34:54 streamer volumio[860]: info: MRS: volumioStreaming STOPPED Jul 13 07:34:54 streamer volumio[860]: info: MRS: SNAPSERVER STOPPED Jul 13 07:34:54 streamer volumio[860]: info: MRS: SNAPCLIENT STOPPED Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::volumioGetState Jul 13 07:34:54 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:54 streamer volumio[860]: info: Listing playlists Jul 13 07:34:54 streamer volumio[860]: info: Listing playlists Jul 13 07:34:54 streamer volumio[860]: info: Asound.conf file written Jul 13 07:34:54 streamer sudo[2007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 13 07:34:54 streamer sudo[2007]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:54 streamer sudo[2007]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:54 streamer volumio[860]: info: Output device has changed, restarting MPD Jul 13 07:34:54 streamer sudo[2012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 13 07:34:54 streamer sudo[2012]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:54 streamer volumio[860]: info: Output device has changed, restarting Shairport Sync Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:54 streamer sudo[2012]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:54 streamer sudo[2015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 13 07:34:54 streamer sudo[2015]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:54 streamer systemd[1]: Stopping Music Player Daemon... Jul 13 07:34:54 streamer volumio[860]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 13 07:34:54 streamer volumio[860]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 13 07:34:54 streamer systemd[1]: mpd.service: Succeeded. Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer systemd[1]: Stopped Music Player Daemon. Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jul 13 07:34:54 streamer volumio[860]: info: MRS: Pushing multiroomSync output for this device Jul 13 07:34:54 streamer volumio[860]: info: MRS: Pushing multiroomSync output Jul 13 07:34:54 streamer volumio[860]: info: Adding audio output: Jul 13 07:34:54 streamer sudo[2024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name streamer Jul 13 07:34:54 streamer sudo[2024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:54 streamer volumio[860]: info: Adding audio output: Jul 13 07:34:54 streamer volumio[860]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer sudo[1290]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:54 streamer systemd[1]: Starting Music Player Daemon... Jul 13 07:34:54 streamer sudo[2024]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jul 13 07:34:54 streamer volumio[860]: info: Adding METAVOLUMIO REST API Endpoints Jul 13 07:34:54 streamer volumio[860]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jul 13 07:34:54 streamer volumio[860]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jul 13 07:34:54 streamer volumio[860]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jul 13 07:34:54 streamer volumio[860]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jul 13 07:34:54 streamer volumio[860]: info: Adding Manifest REST API Endpoints Jul 13 07:34:54 streamer volumio[860]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jul 13 07:34:54 streamer volumio[860]: info: Preparing CD Folders Jul 13 07:34:54 streamer volumio[860]: info: Adding CD REST API Endpoints Jul 13 07:34:54 streamer volumio[860]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jul 13 07:34:54 streamer volumio[860]: info: Starting UDEV Watcher for CD Jul 13 07:34:54 streamer volumio[860]: info: Detecting CD presence with UDEV Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jul 13 07:34:54 streamer volumio[860]: info: Adding inputs REST Endpoints Jul 13 07:34:54 streamer volumio[860]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jul 13 07:34:54 streamer volumio[860]: info: Scanning Audio Inputs Jul 13 07:34:54 streamer sudo[2020]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 13 07:34:54 streamer sudo[2020]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:54 streamer sudo[2020]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:54 streamer volumio[860]: info: Checking against Known Cards name Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 13 07:34:54 streamer volumio[860]: info: [1720848894646] CoreMusicLibrary::Adding element Dummy Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 13 07:34:54 streamer volumio[860]: Cannot find translation for source Dummy Jul 13 07:34:54 streamer volumio[860]: info: Checking against Known Cards name Jul 13 07:34:54 streamer volumio[860]: info: Adding Server instance for streaming Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jul 13 07:34:54 streamer volumio[860]: error: Hi Res Audio Failed Login: Missing Login Data Jul 13 07:34:54 streamer volumio[860]: info: Adding HIGHRESAUDIO REST API Endpoints Jul 13 07:34:54 streamer volumio[860]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jul 13 07:34:54 streamer volumio[860]: info: Refreshing TIDAL token Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jul 13 07:34:54 streamer volumio[860]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jul 13 07:34:54 streamer sudo[2034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 13 07:34:54 streamer sudo[2034]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:54 streamer volumio[860]: info: Stopping AccessToken refresher cron for QOBUZ Jul 13 07:34:54 streamer sudo[2034]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:54 streamer volumio[860]: info: AccessToken refresher cron started for QOBUZ Jul 13 07:34:54 streamer volumio[860]: info: Adding QOBUZ REST API Endpoints Jul 13 07:34:54 streamer volumio[860]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jul 13 07:34:54 streamer volumio[860]: info: Bluetooth name changed to streamer Jul 13 07:34:54 streamer volumio[860]: info: MPD Permissions set Jul 13 07:34:54 streamer volumio[860]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:54 streamer volumio[860]: info: Starting Shairport Sync Jul 13 07:34:54 streamer volumio[860]: info: Preparing to generate the ALSA configuration file Jul 13 07:34:54 streamer sudo[2042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 13 07:34:54 streamer sudo[2042]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:54 streamer volumio[860]: info: The plugin peppy_alsa_pipe has an ALSA contribution file peppy_in.peppy_out.6.conf Jul 13 07:34:54 streamer volumio[860]: info: Reading ALSA contributions from plugins. Jul 13 07:34:54 streamer volumio[860]: info: Asound.conf file written Jul 13 07:34:54 streamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 13 07:34:54 streamer systemd[1]: shairport-sync.service: Succeeded. Jul 13 07:34:54 streamer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 13 07:34:54 streamer sudo[2046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 13 07:34:54 streamer sudo[2046]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:54 streamer sudo[2046]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:54 streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 13 07:34:54 streamer sudo[2042]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:54 streamer volumio[860]: info: Output device has changed, restarting MPD Jul 13 07:34:55 streamer sudo[2053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 13 07:34:55 streamer sudo[2053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer volumio[860]: info: Output device has changed, restarting Shairport Sync Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:55 streamer sudo[2053]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:55 streamer sudo[2056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 13 07:34:55 streamer sudo[2056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 13 07:34:55 streamer systemd[1]: mpd.service: Succeeded. Jul 13 07:34:55 streamer systemd[1]: Stopped Music Player Daemon. Jul 13 07:34:55 streamer volumio[860]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 13 07:34:55 streamer volumio[860]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: Preparing to generate the ALSA configuration file Jul 13 07:34:55 streamer volumio[860]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 13 07:34:55 streamer volumio[860]: info: The plugin peppy_alsa_pipe has an ALSA contribution file peppy_in.peppy_out.6.conf Jul 13 07:34:55 streamer volumio[860]: info: Reading ALSA contributions from plugins. Jul 13 07:34:55 streamer systemd[1]: Starting Music Player Daemon... Jul 13 07:34:55 streamer volumio[860]: info: MPD Permissions set Jul 13 07:34:55 streamer volumio[860]: info: Shairport-Sync Started Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: Starting Shairport Sync Jul 13 07:34:55 streamer sudo[2061]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 13 07:34:55 streamer sudo[2061]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer volumio[860]: info: Asound.conf file written Jul 13 07:34:55 streamer sudo[2061]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:55 streamer sudo[2069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 13 07:34:55 streamer sudo[2069]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 13 07:34:55 streamer systemd[1]: shairport-sync.service: Succeeded. Jul 13 07:34:55 streamer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 13 07:34:55 streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 13 07:34:55 streamer sudo[2074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 13 07:34:55 streamer sudo[2074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer sudo[2069]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:55 streamer sudo[2074]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:55 streamer volumio[860]: info: Output device has changed, restarting MPD Jul 13 07:34:55 streamer sudo[2082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 13 07:34:55 streamer sudo[2082]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer volumio[860]: info: Output device has changed, restarting Shairport Sync Jul 13 07:34:55 streamer sudo[2082]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:55 streamer sudo[2085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 13 07:34:55 streamer sudo[2085]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 13 07:34:55 streamer systemd[1]: mpd.service: Succeeded. Jul 13 07:34:55 streamer systemd[1]: Stopped Music Player Daemon. Jul 13 07:34:55 streamer volumio[860]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 13 07:34:55 streamer volumio[860]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: Access Token successfully retrieved Jul 13 07:34:55 streamer volumio[860]: info: MPD Permissions set Jul 13 07:34:55 streamer volumio[860]: info: Shairport-Sync Started Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer systemd[1]: Starting Music Player Daemon... Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 07:34:55 streamer volumio[860]: info: Starting Shairport Sync Jul 13 07:34:55 streamer sudo[2098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 13 07:34:55 streamer sudo[2098]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer sudo[2090]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 13 07:34:55 streamer sudo[2090]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:55 streamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 13 07:34:55 streamer systemd[1]: shairport-sync.service: Succeeded. Jul 13 07:34:55 streamer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 13 07:34:55 streamer sudo[2090]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:55 streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::volumioGetState Jul 13 07:34:55 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:55 streamer sudo[2098]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:55 streamer volumio[860]: info: Shairport-Sync Started Jul 13 07:34:55 streamer volumio[860]: info: Successfully retrieved User Session From TIDAL Jul 13 07:34:55 streamer volumio[860]: info: Successfully retrieved User Subscription From TIDAL Jul 13 07:34:55 streamer volumio[860]: info: Adding TIDAL to Browse Sources Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 13 07:34:55 streamer volumio[860]: info: [1720848895793] CoreMusicLibrary::Adding element TIDAL Jul 13 07:34:55 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 13 07:34:55 streamer volumio[860]: Cannot find translation for source Dummy Jul 13 07:34:55 streamer volumio[860]: Cannot find translation for source TIDAL Jul 13 07:34:55 streamer volumio[860]: info: Stopping AccessToken refresher cron Jul 13 07:34:55 streamer volumio[860]: info: AccessToken refresher cron started Jul 13 07:34:55 streamer volumio[860]: info: Adding TIDAL REST API Endpoints Jul 13 07:34:55 streamer volumio[860]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jul 13 07:34:56 streamer mpd[2102]: Jul 13 07:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 13 07:34:56 streamer systemd[1]: Started Music Player Daemon. Jul 13 07:34:56 streamer sudo[2015]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:56 streamer sudo[2085]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:56 streamer sudo[2056]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:56 streamer sudo[2112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jul 13 07:34:56 streamer sudo[2112]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:56 streamer volumio[860]: error: MPD error: The expression evaluated to a falsy value: Jul 13 07:34:56 streamer volumio[860]: assert.ok(self.idling) Jul 13 07:34:56 streamer volumio[860]: error: The expression evaluated to a falsy value: Jul 13 07:34:56 streamer volumio[860]: assert.ok(self.idling) Jul 13 07:34:56 streamer volumio[860]: error: MPD error: The expression evaluated to a falsy value: Jul 13 07:34:56 streamer volumio[860]: assert.ok(self.idling) Jul 13 07:34:56 streamer volumio[860]: error: The expression evaluated to a falsy value: Jul 13 07:34:56 streamer volumio[860]: assert.ok(self.idling) Jul 13 07:34:56 streamer volumio[860]: error: updateQueue error: null Jul 13 07:34:56 streamer systemd[1]: Started MyVolumio SSH Tunnel. Jul 13 07:34:56 streamer sudo[2112]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:56 streamer volumio[860]: info: Remote SSH Started Jul 13 07:34:56 streamer autossh[2115]: port set to 0, monitoring disabled Jul 13 07:34:56 streamer autossh[2115]: starting ssh (count 1) Jul 13 07:34:56 streamer autossh[2115]: ssh child pid is 2118 Jul 13 07:34:56 streamer volumio[860]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 13 07:34:56 streamer volumio[860]: info: CoreCommandRouter::volumioGetState Jul 13 07:34:56 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:56 streamer volumiossh-tunnel[2114]: Warning: Permanently added '[eu10.myvolumio.org]:2222,[46.101.141.203]:2222' (RSA) to the list of known hosts. Jul 13 07:34:56 streamer volumio[860]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 13 07:34:56 streamer volumio[860]: info: The plugin peppy_alsa_pipe has an ALSA contribution file peppy_in.peppy_out.6.conf Jul 13 07:34:56 streamer volumio[860]: info: [peppy_alsa_pipe] Executing /bin/mv /tmp/peppy_alsa_pipe_no_peppy.conf /etc/alsa/conf.d/90-volumio-no-peppy.conf Jul 13 07:34:56 streamer sudo[2121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /tmp/peppy_alsa_pipe_no_peppy.conf /etc/alsa/conf.d/90-volumio-no-peppy.conf Jul 13 07:34:56 streamer sudo[2121]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:56 streamer sudo[2121]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:56 streamer volumio[860]: info: [peppy_alsa_pipe] Executing /usr/sbin/alsactl -L -R nrestore Jul 13 07:34:56 streamer sudo[2125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Jul 13 07:34:57 streamer sudo[2125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:57 streamer sudo[2125]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:57 streamer volumio[860]: info: [peppy_alsa_pipe] Executing /usr/bin/sudo /bin/chmod 777 /etc/mpd.conf Jul 13 07:34:57 streamer sudo[2129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/sudo /bin/chmod 777 /etc/mpd.conf Jul 13 07:34:57 streamer sudo[2129]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:57 streamer sudo[2130]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 13 07:34:57 streamer sudo[2130]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:57 streamer sudo[2130]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:57 streamer sudo[2129]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:57 streamer sudo[2133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 13 07:34:57 streamer sudo[2133]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:57 streamer systemd[1]: Stopping Music Player Daemon... Jul 13 07:34:57 streamer systemd[1]: mpd.service: Succeeded. Jul 13 07:34:57 streamer systemd[1]: Stopped Music Player Daemon. Jul 13 07:34:57 streamer systemd[1]: Starting Music Player Daemon... Jul 13 07:34:57 streamer sudo[2135]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 13 07:34:57 streamer sudo[2135]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:57 streamer sudo[2135]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:57 streamer sudo[2140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jul 13 07:34:57 streamer sudo[2140]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:57 streamer volumio[860]: info: Executing endpoint metavolumio Jul 13 07:34:57 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jul 13 07:34:57 streamer systemd[1]: Started Volumio Bluetooth Module. Jul 13 07:34:57 streamer sudo[2140]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:57 streamer volumio[860]: info: Volumio BT Module successfully started Jul 13 07:34:57 streamer sudo[2143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jul 13 07:34:57 streamer sudo[2143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:57 streamer volumiobt[2142]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jul 13 07:34:57 streamer sudo[2143]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:57 streamer volumio[860]: info: TidalConnect service stoped! Jul 13 07:34:57 streamer volumio[860]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 13 07:34:57 streamer volumio[860]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 13 07:34:57 streamer sudo[2155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 13 07:34:57 streamer sudo[2155]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:57 streamer systemd[1]: Started Volumio Tidal Connect Service. Jul 13 07:34:57 streamer sudo[2155]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:58 streamer mpd[2138]: Jul 13 07:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 13 07:34:58 streamer systemd[1]: Started Music Player Daemon. Jul 13 07:34:58 streamer sudo[2133]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:58 streamer volumio[860]: error: updateQueue error: null Jul 13 07:34:58 streamer volumio[860]: info: Executing endpoint tc_getconfig Jul 13 07:34:58 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jul 13 07:34:58 streamer vtcs[2157]: STARTING TidalConnect services, version: 1.4.0.34 Jul 13 07:34:58 streamer vtcs[2157]: STARTED TidalConnect services. Jul 13 07:34:58 streamer volumio[860]: info: Executing endpoint tc_connect Jul 13 07:34:58 streamer volumio[860]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jul 13 07:34:58 streamer volumio[860]: info: Connecting to TidalConnect Jul 13 07:34:58 streamer volumio[860]: info: CoreCommandRouter::servicePushState Jul 13 07:34:58 streamer volumio[860]: info: CoreStateMachine::pushState Jul 13 07:34:58 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:58 streamer volumio[860]: info: CoreCommandRouter::volumioPushState Jul 13 07:34:58 streamer volumio[860]: info: MRS: Pushing multiroomSync output update for this device Jul 13 07:34:58 streamer volumio[860]: info: MRS: Pushing multiroomSync output Jul 13 07:34:58 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:58 streamer volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Jul 13 07:34:58 streamer volumio[860]: info: CoreCommandRouter::servicePushState Jul 13 07:34:58 streamer volumio[860]: info: CoreStateMachine::pushState Jul 13 07:34:58 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:58 streamer volumio[860]: info: CoreCommandRouter::volumioPushState Jul 13 07:34:58 streamer volumio[860]: info: MRS: Pushing multiroomSync output update for this device Jul 13 07:34:58 streamer volumio[860]: info: MRS: Pushing multiroomSync output Jul 13 07:34:58 streamer volumio[860]: info: CorePlayQueue::getTrack 0 Jul 13 07:34:58 streamer volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Jul 13 07:34:58 streamer sudo[2178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jul 13 07:34:58 streamer sudo[2178]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 07:34:58 streamer volumiobt[2142]: pulseaudio: no process found Jul 13 07:34:58 streamer sudo[2178]: pam_unix(sudo:session): session closed for user root Jul 13 07:34:58 streamer dbus-daemon[645]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.28' (uid=1000 pid=2182 comm="/usr/bin/pulseaudio --high-priority=true ") Jul 13 07:34:58 streamer systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jul 13 07:34:58 streamer volumio[860]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 13 07:34:58 streamer dbus-daemon[645]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jul 13 07:34:58 streamer systemd[1]: Started RealtimeKit Scheduling Policy Service. Jul 13 07:34:58 streamer rtkit-daemon[2183]: Successfully called chroot. Jul 13 07:34:58 streamer rtkit-daemon[2183]: Successfully dropped privileges. Jul 13 07:34:58 streamer rtkit-daemon[2183]: Successfully limited resources. Jul 13 07:34:58 streamer rtkit-daemon[2183]: Running. Jul 13 07:34:58 streamer rtkit-daemon[2183]: Watchdog thread running. Jul 13 07:34:58 streamer rtkit-daemon[2183]: Canary thread running. Jul 13 07:34:58 streamer dbus-daemon[645]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.29' (uid=0 pid=2183 comm="/usr/lib/rtkit/rtkit-daemon ") Jul 13 07:34:58 streamer systemd[1]: Starting Authorization Manager... Jul 13 07:34:58 streamer volumio[860]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 13 07:34:58 streamer polkitd[2186]: started daemon version 0.105 using authority implementation `local' version `0.105' Jul 13 07:34:58 streamer dbus-daemon[645]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jul 13 07:34:58 streamer systemd[1]: Started Authorization Manager. Jul 13 07:34:59 streamer pulseaudio[2182]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jul 13 07:34:59 streamer pulseaudio[2182]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jul 13 07:34:59 streamer bluetoothd[707]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSource Jul 13 07:34:59 streamer bluetoothd[707]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSink Jul 13 07:34:59 streamer volumiobt[2142]: Applying permissions Jul 13 07:34:59 streamer volumiobt[2142]: Setting BT discoverable and pairable Jul 13 07:34:59 streamer pulseaudio[2182]: 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 Jul 13 07:34:59 streamer kernel: Bluetooth: RFCOMM TTY layer initialized Jul 13 07:34:59 streamer kernel: Bluetooth: RFCOMM socket layer initialized Jul 13 07:34:59 streamer kernel: Bluetooth: RFCOMM ver 1.11 Jul 13 07:34:59 streamer volumiobt[2142]: [CHG] Controller DC:A6:32:6E:94:2E UUIDs: 00001112-0000-1000-8000-00805f9b34fb Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [55B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [117B blob data] Jul 13 07:34:59 streamer volumiobt[2142]: [bluetooth]# -e power on Jul 13 07:34:59 streamer volumiobt[2142]: Invalid command in menu main: -e Jul 13 07:34:59 streamer volumiobt[2142]: Jul 13 07:34:59 streamer volumiobt[2142]: Use "help" for a list of available commands in a menu. Jul 13 07:34:59 streamer volumiobt[2142]: Use "menu " if you want to enter any submenu. Jul 13 07:34:59 streamer volumiobt[2142]: Use "back" if you want to return to menu main. Jul 13 07:34:59 streamer volumiobt[2142]: [bluetooth]# agent on Jul 13 07:34:59 streamer volumiobt[2142]: Agent is already registered Jul 13 07:34:59 streamer volumiobt[2142]: [bluetooth]# discoverable on Jul 13 07:34:59 streamer volumiobt[2142]: [bluetooth]# pairable on Jul 13 07:34:59 streamer volumiobt[2142]: [bluetooth]# agent NoInputNoOutput Jul 13 07:34:59 streamer volumiobt[2142]: Agent is already registered Jul 13 07:34:59 streamer volumiobt[2142]: [bluetooth]# default-agent Jul 13 07:34:59 streamer volumiobt[2142]: [bluetooth]# quit Jul 13 07:34:59 streamer volumiobt[2142]: [59B blob data] Jul 13 07:34:59 streamer volumio[860]: info: MRS: Getting audio outputs on start Jul 13 07:34:59 streamer volumio[860]: info: MRS: Requesting all other devices output Jul 13 07:34:59 streamer volumio[860]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 13 07:34:59 streamer volumio[860]: TypeError: Cannot read property 'replace' of undefined Jul 13 07:34:59 streamer volumio[860]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Jul 13 07:34:59 streamer volumio[860]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Jul 13 07:34:59 streamer volumio[860]: at listOnTimeout (internal/timers.js:554:17) Jul 13 07:34:59 streamer volumio[860]: at processTimers (internal/timers.js:497:7) Jul 13 07:34:59 streamer volumio[860]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 13 07:35:00 streamer sudo[2206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-13 07:34 Jul 13 07:35:00 streamer sudo[2206]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"