-- Logs begin at Thu 2024-09-05 22:08:45 CEST, end at Thu 2024-09-05 22:13:45 CEST. -- Sep 05 22:12:14 pieranera sudo[2372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 22:12:14 pieranera sudo[2372]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:12:14 pieranera sudo[2372]: pam_unix(sudo:session): session closed for user root Sep 05 22:12:14 pieranera sudo[2374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 22:12:14 pieranera sudo[2374]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:12:14 pieranera sudo[2374]: pam_unix(sudo:session): session closed for user root Sep 05 22:12:14 pieranera volumio[1212]: verbose: New Socket.io Connection to 192.168.1.223 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:14 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:14 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:12:14 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:14 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:14 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:14 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:14 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 05 22:12:14 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:12:14 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:14 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:14 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:14 pieranera volumio[1212]: info: Listing playlists Sep 05 22:12:14 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 05 22:12:16 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 22:12:16 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:12:16 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:12:16 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:12:16 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:12:16 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:16 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:16 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:12:24 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 05 22:12:27 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 22:12:27 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:12:27 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:12:27 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:12:27 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:12:27 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:27 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:27 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:12:55 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 22:12:55 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:12:55 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:12:55 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:12:55 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:12:55 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:12:55 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:12:55 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:12:56 pieranera volumio[1212]: info: MyVolumio Plan changed: premium Sep 05 22:12:56 pieranera volumio[1212]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Sep 05 22:12:56 pieranera volumio[1212]: info: Removing browser output: myVolumio user plan is not superstar Sep 05 22:12:56 pieranera volumio[1212]: info: Removing audio output: Sep 05 22:12:56 pieranera volumio[1212]: info: MYVOLUMIO: Adding device Sep 05 22:12:56 pieranera volumio[1212]: info: MYVOLUMIO: Evaluating Server Sep 05 22:12:56 pieranera volumio[1212]: info: Remote config written successfully Sep 05 22:12:56 pieranera volumio[1212]: info: Starting Tunnel 1 Sep 05 22:12:56 pieranera volumio[1212]: info: Starting Tunnel Connection Checker Sep 05 22:12:57 pieranera volumio[1212]: info: MYVolumio Device disabled Sep 05 22:12:57 pieranera volumio[1212]: info: Setting Geolocation for MyVolumio to eu7 Sep 05 22:12:57 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:12:57 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:12:57 pieranera volumio[1212]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 05 22:12:58 pieranera volumio[1212]: info: Updating MyVolumio device info Sep 05 22:12:58 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:12:58 pieranera volumio[1212]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 05 22:13:01 pieranera volumio[1212]: info: MYVOLUMIO: Adding device Sep 05 22:13:01 pieranera volumio[1212]: info: MYVOLUMIO: Evaluating Server Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 22:13:02 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:13:02 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:02 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:13:02 pieranera sudo[2461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Sep 05 22:13:02 pieranera sudo[2461]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:02 pieranera systemd[1]: Started MyVolumio SSH Tunnel. Sep 05 22:13:02 pieranera sudo[2461]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:02 pieranera volumio[1212]: info: Remote SSH Started Sep 05 22:13:02 pieranera autossh[2464]: port set to 0, monitoring disabled Sep 05 22:13:02 pieranera autossh[2464]: starting ssh (count 1) Sep 05 22:13:02 pieranera autossh[2464]: ssh child pid is 2467 Sep 05 22:13:02 pieranera volumio[1212]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:02 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:02 pieranera volumio[1212]: info: Setting Geolocation for MyVolumio to eu7 Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:02 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:02 pieranera volumiossh-tunnel[2463]: Warning: Permanently added '[eu7.myvolumio.org]:2222,[167.71.43.69]:2222' (RSA) to the list of known hosts. Sep 05 22:13:02 pieranera volumio[1212]: info: MYVolumio Device enabled Sep 05 22:13:02 pieranera volumio[1212]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Sep 05 22:13:02 pieranera volumio[1212]: info: MyVolumio status changed Sep 05 22:13:02 pieranera volumio[1212]: info: Streaming services startup Sep 05 22:13:02 pieranera volumio[1212]: info: Starting Streaming Daemon Sep 05 22:13:02 pieranera volumio[1212]: error: [MyVolumio PluginManager] Could not read cache file: ENOENT: no such file or directory, open '/data/myvolumio/cache.data' Sep 05 22:13:02 pieranera sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 05 22:13:02 pieranera sudo[2469]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:02 pieranera sudo[2469]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:02 pieranera volumio[1212]: error: Cannot start Volumio Streaming Daemon Sep 05 22:13:02 pieranera volumio[1212]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 05 22:13:02 pieranera volumio[1212]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 05 22:13:02 pieranera volumio[1212]: info: Successfully Added MyVolumio device Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Sep 05 22:13:03 pieranera volumio[1212]: info: [1725567183079] Starting BluetoothController Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Sep 05 22:13:03 pieranera sudo[2472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Sep 05 22:13:03 pieranera sudo[2472]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2472]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: MultiRoom plugin initialized Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: STOPPING SNAPCLIENT Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: Snap server stop Sep 05 22:13:03 pieranera sudo[2488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Sep 05 22:13:03 pieranera sudo[2488]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: STOPPING volumioStreaming Sep 05 22:13:03 pieranera sudo[2491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Sep 05 22:13:03 pieranera sudo[2491]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2488]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera sudo[2494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Sep 05 22:13:03 pieranera sudo[2494]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2491]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Sep 05 22:13:03 pieranera sudo[2497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 05 22:13:03 pieranera sudo[2497]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2494]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera sudo[2497]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Sep 05 22:13:03 pieranera volumio[1212]: info: Preparing to generate the ALSA configuration file Sep 05 22:13:03 pieranera volumio[1212]: info: Updating MyVolumio device info Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: Removed streaming files Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: volumioStreaming STOPPED Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: SNAPSERVER STOPPED Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: SNAPCLIENT STOPPED Sep 05 22:13:03 pieranera volumio[1212]: info: Asound.conf file unchanged, so no further update is needed Sep 05 22:13:03 pieranera volumio[1212]: info: Output device has changed, restarting MPD Sep 05 22:13:03 pieranera sudo[2500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 22:13:03 pieranera sudo[2500]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2500]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: Output device has changed, restarting Shairport Sync Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:03 pieranera sudo[2505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 22:13:03 pieranera sudo[2505]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera systemd[1]: Stopping Music Player Daemon... Sep 05 22:13:03 pieranera volumio[1212]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output for this device Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output Sep 05 22:13:03 pieranera volumio[1212]: info: Adding audio output: Sep 05 22:13:03 pieranera volumio[1212]: info: Adding audio output: Sep 05 22:13:03 pieranera sudo[2513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name pieranera Sep 05 22:13:03 pieranera sudo[2513]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2513]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera systemd[1]: mpd.service: Succeeded. Sep 05 22:13:03 pieranera systemd[1]: Stopped Music Player Daemon. Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Sep 05 22:13:03 pieranera volumio[1212]: info: Adding METAVOLUMIO REST API Endpoints Sep 05 22:13:03 pieranera volumio[1212]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Sep 05 22:13:03 pieranera volumio[1212]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Sep 05 22:13:03 pieranera volumio[1212]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Sep 05 22:13:03 pieranera volumio[1212]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Sep 05 22:13:03 pieranera volumio[1212]: info: Preparing CD Folders Sep 05 22:13:03 pieranera volumio[1212]: info: Adding CD REST API Endpoints Sep 05 22:13:03 pieranera volumio[1212]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Sep 05 22:13:03 pieranera volumio[1212]: info: Starting UDEV Watcher for CD Sep 05 22:13:03 pieranera volumio[1212]: info: Detecting CD presence with UDEV Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Sep 05 22:13:03 pieranera volumio[1212]: info: Adding inputs REST Endpoints Sep 05 22:13:03 pieranera volumio[1212]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Sep 05 22:13:03 pieranera volumio[1212]: info: Scanning Audio Inputs Sep 05 22:13:03 pieranera volumio[1212]: info: Checking against Known Cards name Sep 05 22:13:03 pieranera volumio[1212]: info: Checking against Known Cards name Sep 05 22:13:03 pieranera volumio[1212]: info: Checking against Known Cards name Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 05 22:13:03 pieranera volumio[1212]: info: [1725567183467] CoreMusicLibrary::Adding element USB Audio CODEC Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 22:13:03 pieranera volumio[1212]: Cannot find translation for source USB Audio CODEC Sep 05 22:13:03 pieranera volumio[1212]: info: Checking against Known Cards name Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 05 22:13:03 pieranera volumio[1212]: info: [1725567183468] CoreMusicLibrary::Adding element B525 HD Webcam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 22:13:03 pieranera volumio[1212]: Cannot find translation for source USB Audio CODEC Sep 05 22:13:03 pieranera volumio[1212]: Cannot find translation for source B525 HD Webcam Sep 05 22:13:03 pieranera volumio[1212]: info: Checking against Known Cards name Sep 05 22:13:03 pieranera volumio[1212]: info: Adding Server instance for streaming Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Sep 05 22:13:03 pieranera systemd[1]: Starting Music Player Daemon... Sep 05 22:13:03 pieranera volumio[1212]: error: Hi Res Audio Failed Login: Missing Login Data Sep 05 22:13:03 pieranera volumio[1212]: info: Adding HIGHRESAUDIO REST API Endpoints Sep 05 22:13:03 pieranera volumio[1212]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Sep 05 22:13:03 pieranera volumio[1212]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Sep 05 22:13:03 pieranera sudo[2522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 05 22:13:03 pieranera sudo[2522]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera volumio[1212]: info: Stopping AccessToken refresher cron Sep 05 22:13:03 pieranera sudo[2522]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera sudo[2516]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 05 22:13:03 pieranera sudo[2516]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2516]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: AccessToken refresher cron started Sep 05 22:13:03 pieranera volumio[1212]: info: Stopping AccessToken refresher cron for QOBUZ Sep 05 22:13:03 pieranera volumio[1212]: info: AccessToken refresher cron started for QOBUZ Sep 05 22:13:03 pieranera volumio[1212]: info: Adding TIDAL REST API Endpoints Sep 05 22:13:03 pieranera volumio[1212]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Sep 05 22:13:03 pieranera volumio[1212]: info: Adding QOBUZ REST API Endpoints Sep 05 22:13:03 pieranera volumio[1212]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Sep 05 22:13:03 pieranera volumio[1212]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'pieranera' Sep 05 22:13:03 pieranera volumio[1212]: Can't get device info: No such device Sep 05 22:13:03 pieranera volumio[1212]: info: MPD Permissions set Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: Starting Shairport Sync Sep 05 22:13:03 pieranera volumio[1212]: info: Preparing to generate the ALSA configuration file Sep 05 22:13:03 pieranera sudo[2534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 22:13:03 pieranera sudo[2534]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera volumio[1212]: info: Asound.conf file unchanged, so no further update is needed Sep 05 22:13:03 pieranera volumio[1212]: info: Output device has changed, restarting MPD Sep 05 22:13:03 pieranera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 22:13:03 pieranera systemd[1]: shairport-sync.service: Succeeded. Sep 05 22:13:03 pieranera systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 22:13:03 pieranera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 22:13:03 pieranera sudo[2534]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera sudo[2538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 22:13:03 pieranera sudo[2538]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2538]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: Output device has changed, restarting Shairport Sync Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:03 pieranera sudo[2541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 22:13:03 pieranera sudo[2541]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 05 22:13:03 pieranera systemd[1]: mpd.service: Succeeded. Sep 05 22:13:03 pieranera systemd[1]: Stopped Music Player Daemon. Sep 05 22:13:03 pieranera systemd[1]: Starting Music Player Daemon... Sep 05 22:13:03 pieranera volumio[1212]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: Preparing to generate the ALSA configuration file Sep 05 22:13:03 pieranera volumio[1212]: info: MPD Permissions set Sep 05 22:13:03 pieranera volumio[1212]: info: Shairport-Sync Started Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 05 22:13:03 pieranera sudo[2548]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 05 22:13:03 pieranera sudo[2548]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2548]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: Asound.conf file unchanged, so no further update is needed Sep 05 22:13:03 pieranera volumio[1212]: info: Output device has changed, restarting MPD Sep 05 22:13:03 pieranera sudo[2560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 22:13:03 pieranera sudo[2560]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera volumio[1212]: info: Output device has changed, restarting Shairport Sync Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:03 pieranera sudo[2563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 22:13:03 pieranera sudo[2563]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 05 22:13:03 pieranera systemd[1]: mpd.service: Succeeded. Sep 05 22:13:03 pieranera systemd[1]: Stopped Music Player Daemon. Sep 05 22:13:03 pieranera systemd[1]: Starting Music Player Daemon... Sep 05 22:13:03 pieranera volumio[1212]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 22:13:03 pieranera volumio[1212]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: Starting Shairport Sync Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 22:13:03 pieranera sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2568]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 05 22:13:03 pieranera sudo[2568]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera sudo[2568]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 05 22:13:03 pieranera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 22:13:03 pieranera systemd[1]: shairport-sync.service: Succeeded. Sep 05 22:13:03 pieranera systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 22:13:03 pieranera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 22:13:03 pieranera sudo[2572]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 22:13:03 pieranera volumio[1212]: info: Shairport-Sync Started Sep 05 22:13:03 pieranera volumio[1212]: info: Starting Shairport Sync Sep 05 22:13:03 pieranera sudo[2585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 22:13:03 pieranera sudo[2585]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:03 pieranera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 22:13:03 pieranera systemd[1]: shairport-sync.service: Succeeded. Sep 05 22:13:03 pieranera systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 22:13:03 pieranera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 22:13:03 pieranera sudo[2585]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:03 pieranera volumio[1212]: info: Shairport-Sync Started Sep 05 22:13:03 pieranera volumio[1212]: info: Successfully Updated MyVolumio device Sep 05 22:13:04 pieranera sudo[2560]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:04 pieranera volumio[1212]: info: MPD Permissions set Sep 05 22:13:05 pieranera mpd[2579]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 05 22:13:05 pieranera mpd[2579]: output: No 'audio_output' defined in config file Sep 05 22:13:05 pieranera mpd[2579]: output: Successfully detected a sndio audio device Sep 05 22:13:05 pieranera mpd[2579]: zeroconf: No global port, disabling zeroconf Sep 05 22:13:05 pieranera systemd[1]: Started Music Player Daemon. Sep 05 22:13:05 pieranera sudo[2541]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:05 pieranera sudo[2563]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:05 pieranera sudo[2505]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:05 pieranera volumio[1212]: error: MPD error: The expression evaluated to a falsy value: Sep 05 22:13:05 pieranera volumio[1212]: assert.ok(self.idling) Sep 05 22:13:05 pieranera volumio[1212]: error: The expression evaluated to a falsy value: Sep 05 22:13:05 pieranera volumio[1212]: assert.ok(self.idling) Sep 05 22:13:05 pieranera volumio[1212]: error: MPD error: The expression evaluated to a falsy value: Sep 05 22:13:05 pieranera volumio[1212]: assert.ok(self.idling) Sep 05 22:13:05 pieranera volumio[1212]: error: The expression evaluated to a falsy value: Sep 05 22:13:05 pieranera volumio[1212]: assert.ok(self.idling) Sep 05 22:13:05 pieranera volumio[1212]: error: updateQueue error: null Sep 05 22:13:06 pieranera sudo[2596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Sep 05 22:13:06 pieranera sudo[2596]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:06 pieranera systemd[1]: Started Volumio Bluetooth Module. Sep 05 22:13:06 pieranera sudo[2596]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:06 pieranera volumio[1212]: info: Volumio BT Module successfully started Sep 05 22:13:06 pieranera sudo[2599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Sep 05 22:13:06 pieranera sudo[2599]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:06 pieranera volumiobt[2598]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Sep 05 22:13:06 pieranera sudo[2599]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:06 pieranera volumio[1212]: info: TidalConnect service stoped! Sep 05 22:13:06 pieranera volumio[1212]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 05 22:13:06 pieranera volumio[1212]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 05 22:13:06 pieranera sudo[2611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 05 22:13:06 pieranera sudo[2611]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:06 pieranera systemd[1]: Started Volumio Tidal Connect Service. Sep 05 22:13:06 pieranera sudo[2611]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:06 pieranera volumio[1212]: info: Executing endpoint tc_getconfig Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Sep 05 22:13:06 pieranera vtcs[2613]: STARTING TidalConnect services, version: 1.4.0.34 Sep 05 22:13:06 pieranera vtcs[2613]: STARTED TidalConnect services. Sep 05 22:13:06 pieranera volumio[1212]: info: Executing endpoint tc_connect Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Sep 05 22:13:06 pieranera volumio[1212]: info: Connecting to TidalConnect Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::servicePushState Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::pushState Sep 05 22:13:06 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::volumioPushState Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output update for this device Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output Sep 05 22:13:06 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:06 pieranera volumio[1212]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 05 22:13:06 pieranera volumio[1212]: verbose: CURRENT POSITION 0 Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::syncState stateService stop Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::syncState currentStatus stop Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::pushState Sep 05 22:13:06 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::volumioPushState Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output update for this device Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output Sep 05 22:13:06 pieranera volumio[1212]: info: No code Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::pushState Sep 05 22:13:06 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::volumioPushState Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output update for this device Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::servicePushState Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::pushState Sep 05 22:13:06 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::volumioPushState Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output update for this device Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output Sep 05 22:13:06 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:06 pieranera volumio[1212]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 05 22:13:06 pieranera volumio[1212]: verbose: CURRENT POSITION 0 Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::syncState stateService stop Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::syncState currentStatus stop Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::pushState Sep 05 22:13:06 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::volumioPushState Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output update for this device Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output Sep 05 22:13:06 pieranera volumio[1212]: info: No code Sep 05 22:13:06 pieranera volumio[1212]: info: CoreStateMachine::pushState Sep 05 22:13:06 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:06 pieranera volumio[1212]: info: CoreCommandRouter::volumioPushState Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output update for this device Sep 05 22:13:06 pieranera volumio[1212]: info: MRS: Pushing multiroomSync output Sep 05 22:13:07 pieranera sudo[2635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Sep 05 22:13:07 pieranera sudo[2635]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:08 pieranera volumio[1212]: info: MRS: Getting audio outputs on start Sep 05 22:13:08 pieranera volumio[1212]: info: MRS: Requesting all other devices output Sep 05 22:13:09 pieranera volumiobt[2598]: pulseaudio: no process found Sep 05 22:13:09 pieranera sudo[2635]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:09 pieranera volumio[1212]: info: TidalConnect service started! Sep 05 22:13:10 pieranera dbus-daemon[915]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.22' (uid=1000 pid=2640 comm="/usr/bin/pulseaudio --high-priority=true ") Sep 05 22:13:10 pieranera systemd[1]: Starting RealtimeKit Scheduling Policy Service... Sep 05 22:13:10 pieranera volumio[1212]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 05 22:13:11 pieranera dbus-daemon[915]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Sep 05 22:13:11 pieranera systemd[1]: Started RealtimeKit Scheduling Policy Service. Sep 05 22:13:11 pieranera rtkit-daemon[2641]: Successfully called chroot. Sep 05 22:13:11 pieranera rtkit-daemon[2641]: Successfully dropped privileges. Sep 05 22:13:11 pieranera rtkit-daemon[2641]: Successfully limited resources. Sep 05 22:13:11 pieranera rtkit-daemon[2641]: Running. Sep 05 22:13:11 pieranera rtkit-daemon[2641]: Canary thread running. Sep 05 22:13:11 pieranera rtkit-daemon[2641]: Watchdog thread running. Sep 05 22:13:11 pieranera dbus-daemon[915]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.23' (uid=0 pid=2641 comm="/usr/lib/rtkit/rtkit-daemon ") Sep 05 22:13:11 pieranera systemd[1]: Starting Authorization Manager... Sep 05 22:13:11 pieranera polkitd[2644]: started daemon version 0.105 using authority implementation `local' version `0.105' Sep 05 22:13:11 pieranera dbus-daemon[915]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 05 22:13:11 pieranera systemd[1]: Started Authorization Manager. Sep 05 22:13:11 pieranera volumio[1212]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 05 22:13:11 pieranera pulseaudio[2640]: Failed to open cookie file '/home/volumio/.config/pulse/cookie': No such file or directory Sep 05 22:13:11 pieranera pulseaudio[2640]: Failed to load authentication key '/home/volumio/.config/pulse/cookie': No such file or directory Sep 05 22:13:11 pieranera pulseaudio[2640]: Failed to open cookie file '/home/volumio/.pulse-cookie': No such file or directory Sep 05 22:13:11 pieranera pulseaudio[2640]: Failed to load authentication key '/home/volumio/.pulse-cookie': No such file or directory Sep 05 22:13:11 pieranera pulseaudio[2640]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Sep 05 22:13:11 pieranera pulseaudio[2640]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Sep 05 22:13:11 pieranera volumiobt[2598]: Applying permissions Sep 05 22:13:11 pieranera volumiobt[2598]: Setting BT discoverable and pairable Sep 05 22:13:11 pieranera pulseaudio[2640]: 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 Sep 05 22:13:11 pieranera volumiobt[2598]: [bluetooth]# -e power on Sep 05 22:13:11 pieranera volumiobt[2598]: Invalid command in menu main: -e Sep 05 22:13:11 pieranera volumiobt[2598]: Sep 05 22:13:11 pieranera volumiobt[2598]: Use "help" for a list of available commands in a menu. Sep 05 22:13:11 pieranera volumiobt[2598]: Use "menu " if you want to enter any submenu. Sep 05 22:13:11 pieranera volumiobt[2598]: Use "back" if you want to return to menu main. Sep 05 22:13:11 pieranera volumiobt[2598]: [bluetooth]# agent on Sep 05 22:13:11 pieranera volumiobt[2598]: Failed to register agent object Sep 05 22:13:11 pieranera volumiobt[2598]: [bluetooth]# discoverable on Sep 05 22:13:11 pieranera volumiobt[2598]: No default controller available Sep 05 22:13:11 pieranera volumiobt[2598]: [bluetooth]# pairable on Sep 05 22:13:11 pieranera volumiobt[2598]: No default controller available Sep 05 22:13:11 pieranera volumiobt[2598]: [bluetooth]# agent NoInputNoOutput Sep 05 22:13:11 pieranera volumiobt[2598]: Failed to register agent object Sep 05 22:13:11 pieranera volumiobt[2598]: [bluetooth]# default-agent Sep 05 22:13:11 pieranera volumiobt[2598]: No agent is registered Sep 05 22:13:11 pieranera volumiobt[2598]: [bluetooth]# quit Sep 05 22:13:11 pieranera volumiobt[2598]: [59B blob data] Sep 05 22:13:27 pieranera sudo[2653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 22:13:27 pieranera sudo[2653]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:27 pieranera sudo[2653]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:27 pieranera sudo[2655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 22:13:27 pieranera sudo[2655]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 22:13:27 pieranera sudo[2655]: pam_unix(sudo:session): session closed for user root Sep 05 22:13:28 pieranera volumio[1212]: verbose: New Socket.io Connection to 192.168.1.223 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:13:28 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 05 22:13:28 pieranera volumio[1212]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Sep 05 22:13:28 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:13:28 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: Listing playlists Sep 05 22:13:28 pieranera volumio[1212]: info: Received Get System Info Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 22:13:28 pieranera volumio[1212]: info: Discovery: Getting this device information Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:28 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:28 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 05 22:13:29 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetState Sep 05 22:13:29 pieranera volumio[1212]: info: CorePlayQueue::getTrack 0 Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 22:13:34 pieranera volumio[1212]: info: Retrieving Cloud Streaming UI Sep 05 22:13:34 pieranera volumio[1212]: info: Getting Tidal Cloud Configuration Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 22:13:34 pieranera volumio[1212]: info: Getting Qobuz Cloud Configuration Sep 05 22:13:34 pieranera volumio[1212]: info: Asking plugin for UI Config Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 22:13:34 pieranera volumio[1212]: info: Getting Spotify Cloud Configuration Sep 05 22:13:34 pieranera volumio[1212]: info: Asking plugin for UI Config Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 22:13:34 pieranera volumio[1212]: info: Saving Spotify Acccount Sep 05 22:13:34 pieranera volumio[1212]: info: Got it Sep 05 22:13:34 pieranera volumio[1212]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 22:13:34 pieranera volumio[1212]: info: Got Tidal Cloud Configuration Sep 05 22:13:34 pieranera volumio[1212]: info: Got it Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 22:13:34 pieranera mpd[2579]: exception: No database Sep 05 22:13:34 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 05 22:13:38 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 05 22:13:38 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 22:13:38 pieranera mpd[2579]: exception: No database Sep 05 22:13:39 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 05 22:13:39 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 05 22:13:42 pieranera volumio[1212]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 22:13:42 pieranera mpd[2579]: exception: No database Sep 05 22:13:42 pieranera volumio[1212]: info: Error browsing device NAS2DDEB7 for shares : Error: Command failed: echo volumio | smbclient -L NAS2DDEB7.local. Sep 05 22:13:42 pieranera volumio[1212]: Unable to initialize messaging context Sep 05 22:13:42 pieranera volumio[1212]: do_connect: Connection to NAS2DDEB7.local. failed (Error NT_STATUS_CONNECTION_REFUSED) Sep 05 22:13:44 pieranera volumio[1212]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 22:13:44 pieranera volumio[1212]: Error: dns service error: unknown Sep 05 22:13:44 pieranera volumio[1212]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Sep 05 22:13:44 pieranera volumio[1212]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Sep 05 22:13:44 pieranera volumio[1212]: errorCode: -65537 Sep 05 22:13:44 pieranera volumio[1212]: } Sep 05 22:13:44 pieranera volumio[1212]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 22:13:45 pieranera sudo[2676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-05 22:12 Sep 05 22:13:45 pieranera sudo[2676]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"