-- Logs begin at Sun 2024-03-31 18:25:14 CEST, end at Sun 2024-03-31 18:32:36 CEST. --
Mar 31 18:31:20 sekt88 volumio[724]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Mar 31 18:31:20 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Mar 31 18:31:20 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:21 sekt88 volumio[724]: info: Starting MyVolumio Remote Streaming Endpoints
Mar 31 18:31:21 sekt88 volumio[724]: info: MyVolumio login type: Token
Mar 31 18:31:21 sekt88 volumio[724]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Mar 31 18:31:21 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Mar 31 18:31:24 sekt88 volumio[724]: info: Starting Streaming Service Transparent Proxy
Mar 31 18:31:24 sekt88 volumio[724]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Mar 31 18:31:24 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Mar 31 18:31:24 sekt88 volumio[724]: info: Streaming services startup
Mar 31 18:31:24 sekt88 volumio[724]: info: Starting Streaming Daemon
Mar 31 18:31:24 sekt88 volumio[724]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Mar 31 18:31:25 sekt88 sudo[2058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 31 18:31:25 sekt88 sudo[2058]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:25 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2070, instance 1, run: true
Mar 31 18:31:26 sekt88 sudo[2058]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:26 sekt88 volumio[724]: error: Cannot start Volumio Streaming Daemon
Mar 31 18:31:26 sekt88 volumio[724]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 31 18:31:26 sekt88 volumio[724]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 31 18:31:26 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2077, instance 1, run: true
Mar 31 18:31:26 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2084, instance 1, run: true
Mar 31 18:31:27 sekt88 volumio[724]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Mar 31 18:31:27 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2091, instance 1, run: true
Mar 31 18:31:28 sekt88 volumio[724]: info: MyVolumio token set successfully
Mar 31 18:31:28 sekt88 volumio[724]: info: MYVOLUMIO: Adding device
Mar 31 18:31:28 sekt88 volumio[724]: info: MYVOLUMIO: Evaluating Server
Mar 31 18:31:28 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2100, instance 1, run: true
Mar 31 18:31:28 sekt88 volumio[724]: info: MyVolumio Plan changed: premium
Mar 31 18:31:28 sekt88 volumio[724]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Mar 31 18:31:28 sekt88 volumio[724]: info: Removing browser output: myVolumio user plan is not superstar
Mar 31 18:31:28 sekt88 volumio[724]: info: Removing audio output:
Mar 31 18:31:28 sekt88 volumio[724]: info: MYVOLUMIO: Adding device
Mar 31 18:31:28 sekt88 volumio[724]: info: MYVOLUMIO: Evaluating Server
Mar 31 18:31:28 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2122, instance 1, run: true
Mar 31 18:31:28 sekt88 volumio[724]: info: Remote config written successfully
Mar 31 18:31:28 sekt88 volumio[724]: info: Starting Tunnel 1
Mar 31 18:31:28 sekt88 volumio[724]: info: Starting Tunnel Connection Checker
Mar 31 18:31:29 sekt88 volumio[724]: info: Completed starting MyVolumio Plugin
Mar 31 18:31:29 sekt88 volumio[724]: info: MYVolumio Device enabled
Mar 31 18:31:29 sekt88 volumio[724]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Mar 31 18:31:29 sekt88 volumio[724]: info: MyVolumio status changed
Mar 31 18:31:29 sekt88 volumio[724]: info: Streaming services startup
Mar 31 18:31:29 sekt88 volumio[724]: info: Starting Streaming Daemon
Mar 31 18:31:29 sekt88 volumio[724]: info: Setting Geolocation for MyVolumio to eu5
Mar 31 18:31:29 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:29 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:29 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:30 sekt88 sudo[2145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 31 18:31:30 sekt88 sudo[2145]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:30 sekt88 sudo[2145]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:31 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2147, instance 1, run: true
Mar 31 18:31:31 sekt88 volumio[724]: info: Updating MyVolumio device info
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:31 sekt88 volumio[724]: info: Setting Geolocation for MyVolumio to eu2
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:31 sekt88 volumio[724]: error: Cannot start Volumio Streaming Daemon
Mar 31 18:31:31 sekt88 volumio[724]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 31 18:31:31 sekt88 volumio[724]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Mar 31 18:31:31 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:32 sekt88 volumio[724]: STREAMING PROXY: Starting server on port 3245
Mar 31 18:31:32 sekt88 volumio[724]: Node JS runtime: 14
Mar 31 18:31:32 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Mar 31 18:31:35 sekt88 volumio[724]: info: [1711902695807] Starting BluetoothController
Mar 31 18:31:36 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Mar 31 18:31:41 sekt88 volumio[724]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Mar 31 18:31:42 sekt88 sudo[2156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Mar 31 18:31:42 sekt88 sudo[2156]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:42 sekt88 sudo[2156]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:42 sekt88 volumio[724]: info: MRS: MultiRoom plugin initialized
Mar 31 18:31:42 sekt88 volumio[724]: info: MRS: STOPPING SNAPCLIENT
Mar 31 18:31:42 sekt88 volumio[724]: info: MRS: Snap server stop
Mar 31 18:31:42 sekt88 sudo[2172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Mar 31 18:31:42 sekt88 volumio[724]: info: MRS: STOPPING volumioStreaming
Mar 31 18:31:42 sekt88 sudo[2172]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:42 sekt88 sudo[2174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Mar 31 18:31:42 sekt88 sudo[2174]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:42 sekt88 sudo[2177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Mar 31 18:31:42 sekt88 sudo[2177]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:42 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Mar 31 18:31:42 sekt88 sudo[2180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Mar 31 18:31:42 sekt88 sudo[2180]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:42 sekt88 sudo[2180]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:43 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Mar 31 18:31:43 sekt88 sudo[2172]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:43 sekt88 sudo[2177]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:43 sekt88 sudo[2174]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:43 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Mar 31 18:31:43 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Mar 31 18:31:43 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Mar 31 18:31:43 sekt88 volumio[724]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Mar 31 18:31:43 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Mar 31 18:31:43 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Mar 31 18:31:43 sekt88 volumio[724]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Mar 31 18:31:43 sekt88 volumio[724]: info: Preparing to generate the ALSA configuration file
Mar 31 18:31:44 sekt88 volumio[724]: info: Updating MyVolumio device info
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 31 18:31:44 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 31 18:31:44 sekt88 volumio[724]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Mar 31 18:31:44 sekt88 volumio[724]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Mar 31 18:31:44 sekt88 volumio[724]: info: Reading ALSA contributions from plugins.
Mar 31 18:31:44 sekt88 volumio[724]: info: Successfully Added MyVolumio device
Mar 31 18:31:44 sekt88 volumio[724]: info: MRS: Removed streaming files
Mar 31 18:31:44 sekt88 volumio[724]: info: MRS: volumioStreaming STOPPED
Mar 31 18:31:44 sekt88 volumio[724]: info: MRS: SNAPSERVER STOPPED
Mar 31 18:31:44 sekt88 volumio[724]: info: MRS: SNAPCLIENT STOPPED
Mar 31 18:31:44 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2224, instance 1, run: true
Mar 31 18:31:44 sekt88 volumio[724]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6
Mar 31 18:31:45 sekt88 volumio[724]: info: CoreCommandRouter::volumioGetState
Mar 31 18:31:45 sekt88 volumio[724]: info: CorePlayQueue::getTrack 0
Mar 31 18:31:45 sekt88 volumio[724]: info: Successfully Updated MyVolumio device
Mar 31 18:31:45 sekt88 volumio[724]: info: Asound.conf file written
Mar 31 18:31:46 sekt88 sudo[2236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Mar 31 18:31:46 sekt88 sudo[2238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Mar 31 18:31:46 sekt88 sudo[2236]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:46 sekt88 sudo[2238]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:47 sekt88 sudo[2238]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:47 sekt88 systemd[1]: Started MyVolumio SSH Tunnel.
Mar 31 18:31:47 sekt88 sudo[2236]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:47 sekt88 volumio[724]: info: Output device has changed, restarting MPD
Mar 31 18:31:47 sekt88 volumio[724]: info: Output device has changed, restarting Shairport Sync
Mar 31 18:31:47 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 18:31:47 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:47 sekt88 sudo[2248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 31 18:31:47 sekt88 sudo[2246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 31 18:31:47 sekt88 sudo[2246]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:47 sekt88 sudo[2248]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:47 sekt88 sudo[2246]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:48 sekt88 systemd[1]: Stopping Music Player Daemon...
Mar 31 18:31:48 sekt88 volumio[724]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 31 18:31:48 sekt88 volumio[724]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Mar 31 18:31:48 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 18:31:48 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Mar 31 18:31:48 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 31 18:31:48 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Mar 31 18:31:48 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Mar 31 18:31:48 sekt88 volumio[724]: info: MRS: Pushing multiroomSync output for this device
Mar 31 18:31:48 sekt88 volumio[724]: info: MRS: Pushing multiroomSync output
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding audio output:
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding audio output:
Mar 31 18:31:48 sekt88 volumio[724]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Mar 31 18:31:48 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 18:31:48 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Mar 31 18:31:48 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding METAVOLUMIO REST API Endpoints
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Mar 31 18:31:48 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding Manifest REST API Endpoints
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
Mar 31 18:31:48 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Mar 31 18:31:48 sekt88 volumio[724]: info: Preparing CD Folders
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding CD REST API Endpoints
Mar 31 18:31:48 sekt88 volumio[724]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Mar 31 18:31:48 sekt88 volumio[724]: info: Starting UDEV Watcher for CD
Mar 31 18:31:49 sekt88 sudo[2257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name SEKT88
Mar 31 18:31:49 sekt88 sudo[2257]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:49 sekt88 sudo[2257]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:49 sekt88 volumio[724]: info: Detecting CD presence with UDEV
Mar 31 18:31:49 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Mar 31 18:31:49 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Mar 31 18:31:49 sekt88 volumio[724]: info: Adding inputs REST Endpoints
Mar 31 18:31:49 sekt88 volumio[724]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Mar 31 18:31:49 sekt88 volumio[724]: info: Scanning Audio Inputs
Mar 31 18:31:50 sekt88 autossh[2261]: port set to 0, monitoring disabled
Mar 31 18:31:50 sekt88 autossh[2261]: starting ssh (count 1)
Mar 31 18:31:50 sekt88 autossh[2261]: ssh child pid is 2267
Mar 31 18:31:50 sekt88 volumio[724]: info: Checking against Known Cards name
Mar 31 18:31:50 sekt88 volumio[724]: info: Adding Server instance for streaming
Mar 31 18:31:50 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Mar 31 18:31:51 sekt88 volumio[724]: error: Hi Res Audio Failed Login: Missing Login Data
Mar 31 18:31:51 sekt88 volumio[724]: info: Adding HIGHRESAUDIO REST API Endpoints
Mar 31 18:31:51 sekt88 volumio[724]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Mar 31 18:31:51 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Mar 31 18:31:51 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Mar 31 18:31:51 sekt88 volumio[724]: info: Refreshing QOBUZ token
Mar 31 18:31:51 sekt88 volumio[724]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Mar 31 18:31:51 sekt88 volumio[724]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting
Mar 31 18:31:51 sekt88 volumio[724]: info: Stopping AccessToken refresher cron
Mar 31 18:31:52 sekt88 volumiossh-tunnel[2244]: Warning: Permanently added '[eu2.myvolumio.org]:2222,[185.14.187.123]:2222' (RSA) to the list of known hosts.
Mar 31 18:31:52 sekt88 volumio[724]: info: AccessToken refresher cron started
Mar 31 18:31:52 sekt88 volumio[724]: info: Adding TIDAL REST API Endpoints
Mar 31 18:31:52 sekt88 volumio[724]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Mar 31 18:31:53 sekt88 sudo[2269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Mar 31 18:31:53 sekt88 sudo[2269]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:53 sekt88 systemd[1]: Started Volumio Bluetooth Module.
Mar 31 18:31:55 sekt88 sudo[2269]: pam_unix(sudo:session): session closed for user root
Mar 31 18:31:57 sekt88 volumio[724]: info: Successfully Updated MyVolumio device
Mar 31 18:31:57 sekt88 sudo[2272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Mar 31 18:31:57 sekt88 sudo[2272]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:31:58 sekt88 volumio[724]: info: Successfully Added MyVolumio device
Mar 31 18:31:58 sekt88 volumiobt[2271]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Mar 31 18:31:58 sekt88 sudo[2272]: pam_unix(sudo:session): session closed for user root
Mar 31 18:32:02 sekt88 sudo[2279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Mar 31 18:32:02 sekt88 sudo[2279]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:32:03 sekt88 volumiobt[2271]: pulseaudio: no process found
Mar 31 18:32:03 sekt88 sudo[2279]: pam_unix(sudo:session): session closed for user root
Mar 31 18:32:10 sekt88 dbus-daemon[428]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.22' (uid=1000 pid=2283 comm="/usr/bin/pulseaudio --high-priority=true ")
Mar 31 18:32:13 sekt88 volumio[724]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Mar 31 18:32:14 sekt88 volumio[724]: info: Bluetooth name changed to SEKT88
Mar 31 18:32:14 sekt88 volumio[724]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Mar 31 18:32:14 sekt88 systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Mar 31 18:32:14 sekt88 dbus-daemon[428]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Mar 31 18:32:14 sekt88 systemd[1]: Started RealtimeKit Scheduling Policy Service.
Mar 31 18:32:14 sekt88 rtkit-daemon[2284]: Successfully called chroot.
Mar 31 18:32:14 sekt88 rtkit-daemon[2284]: Successfully dropped privileges.
Mar 31 18:32:14 sekt88 rtkit-daemon[2284]: Successfully limited resources.
Mar 31 18:32:14 sekt88 rtkit-daemon[2284]: Running.
Mar 31 18:32:14 sekt88 rtkit-daemon[2284]: Canary thread running.
Mar 31 18:32:14 sekt88 rtkit-daemon[2284]: Watchdog thread running.
Mar 31 18:32:14 sekt88 dbus-daemon[428]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.23' (uid=0 pid=2284 comm="/usr/lib/rtkit/rtkit-daemon ")
Mar 31 18:32:14 sekt88 systemd[1]: Starting Authorization Manager...
Mar 31 18:32:15 sekt88 volumio[724]: info: MPD Permissions set
Mar 31 18:32:15 sekt88 systemd[1]: mpd.service: Succeeded.
Mar 31 18:32:15 sekt88 systemd[1]: Stopped Music Player Daemon.
Mar 31 18:32:15 sekt88 systemd[1]: Starting Music Player Daemon...
Mar 31 18:32:15 sekt88 volumio[724]: info: Remote SSH Started
Mar 31 18:32:15 sekt88 polkitd[2287]: started daemon version 0.105 using authority implementation `local' version `0.105'
Mar 31 18:32:15 sekt88 dbus-daemon[428]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Mar 31 18:32:15 sekt88 systemd[1]: Started Authorization Manager.
Mar 31 18:32:15 sekt88 sudo[2291]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Mar 31 18:32:15 sekt88 sudo[2291]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 18:32:15 sekt88 sudo[2291]: pam_unix(sudo:session): session closed for user root
Mar 31 18:32:16 sekt88 pulseaudio[2283]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Mar 31 18:32:16 sekt88 pulseaudio[2283]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Mar 31 18:32:16 sekt88 pulseaudio[2283]: 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
Mar 31 18:32:16 sekt88 bluetoothd[569]: Endpoint registered: sender=:1.43 path=/MediaEndpoint/A2DPSource
Mar 31 18:32:16 sekt88 bluetoothd[569]: Endpoint registered: sender=:1.43 path=/MediaEndpoint/A2DPSink
Mar 31 18:32:16 sekt88 volumiobt[2271]: Applying permissions
Mar 31 18:32:16 sekt88 volumiobt[2271]: Setting BT discoverable and pairable
Mar 31 18:32:17 sekt88 kernel: Bluetooth: RFCOMM TTY layer initialized
Mar 31 18:32:17 sekt88 kernel: Bluetooth: RFCOMM socket layer initialized
Mar 31 18:32:17 sekt88 kernel: Bluetooth: RFCOMM ver 1.11
Mar 31 18:32:17 sekt88 volumiobt[2271]: [CHG] Controller D8:3A:DD:32:9F:95 Class: 0x0008041c
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [91B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [55B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [117B blob data]
Mar 31 18:32:17 sekt88 volumiobt[2271]: [bluetooth]# -e power on
Mar 31 18:32:17 sekt88 volumiobt[2271]: Invalid command in menu main: -e
Mar 31 18:32:17 sekt88 volumiobt[2271]:
Mar 31 18:32:17 sekt88 volumiobt[2271]: Use "help" for a list of available commands in a menu.
Mar 31 18:32:17 sekt88 volumiobt[2271]: Use "menu " if you want to enter any submenu.
Mar 31 18:32:17 sekt88 volumiobt[2271]: Use "back" if you want to return to menu main.
Mar 31 18:32:17 sekt88 volumiobt[2271]: [bluetooth]# agent on
Mar 31 18:32:17 sekt88 volumiobt[2271]: Agent is already registered
Mar 31 18:32:17 sekt88 volumiobt[2271]: [bluetooth]# discoverable on
Mar 31 18:32:17 sekt88 volumiobt[2271]: [bluetooth]# pairable on
Mar 31 18:32:17 sekt88 volumiobt[2271]: [bluetooth]# agent NoInputNoOutput
Mar 31 18:32:17 sekt88 volumiobt[2271]: Agent is already registered
Mar 31 18:32:17 sekt88 volumiobt[2271]: [bluetooth]# default-agent
Mar 31 18:32:17 sekt88 volumiobt[2271]: [bluetooth]# quit
Mar 31 18:32:17 sekt88 volumiobt[2271]: [59B blob data]
Mar 31 18:32:22 sekt88 dbus-daemon[428]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30005ms)
Mar 31 18:32:22 sekt88 dbus-daemon[428]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30001ms)
Mar 31 18:32:28 sekt88 volumio[724]: info: camilladsp spawned new process with pid 2307, instance 1, run: true
Mar 31 18:32:28 sekt88 volumio[724]: info: MRS: Getting audio outputs on start
Mar 31 18:32:28 sekt88 volumio[724]: info: MRS: Requesting all other devices output
Mar 31 18:32:28 sekt88 volumio[724]: error: MyVolumio Plugins failed to start in a timely fashion
Mar 31 18:32:28 sekt88 volumio[724]: error: Plugin audio_interface multiroom failed to complete 'onStart' in a timely fashion
Mar 31 18:32:28 sekt88 volumio[724]: error: Plugin music_service qobuz failed to complete 'onStart' in a timely fashion
Mar 31 18:32:28 sekt88 volumio[724]: error: Plugin music_service tidalconnect failed to complete 'onStart' in a timely fashion
Mar 31 18:32:28 sekt88 volumio[724]: info: BOOT COMPLETED
Mar 31 18:32:28 sekt88 mpd[2297]: Mar 31 18:32 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 31 18:32:28 sekt88 volumio[724]: [Metrics] CommandRouter: 148s 964.29ms
Mar 31 18:32:28 sekt88 volumio[724]: info: CoreCommandRouter::volumiosetStartupVolume
Mar 31 18:32:28 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 18:32:28 sekt88 volumio[724]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 18:32:29 sekt88 volumio[724]: info: CoreCommandRouter::Close All Modals sent
Mar 31 18:32:29 sekt88 volumio[724]: info: CoreCommandRouter::Close All Modals sent
Mar 31 18:32:30 sekt88 systemd[1]: Started Music Player Daemon.
Mar 31 18:32:32 sekt88 volumio[724]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 31 18:32:33 sekt88 volumio[724]: Error: write EPIPE
Mar 31 18:32:33 sekt88 volumio[724]: at afterWriteDispatched (internal/stream_base_commons.js:156:25)
Mar 31 18:32:33 sekt88 volumio[724]: at writeGeneric (internal/stream_base_commons.js:147:3)
Mar 31 18:32:33 sekt88 volumio[724]: at Socket._writeGeneric (net.js:785:11)
Mar 31 18:32:33 sekt88 volumio[724]: at Socket._write (net.js:797:8)
Mar 31 18:32:33 sekt88 volumio[724]: at writeOrBuffer (internal/streams/writable.js:358:12)
Mar 31 18:32:33 sekt88 volumio[724]: at Socket.Writable.write (internal/streams/writable.js:303:10)
Mar 31 18:32:33 sekt88 volumio[724]: at /myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-native/lib/handshake.js:82:16
Mar 31 18:32:33 sekt88 volumio[724]: at Socket.readable (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-native/lib/readline.js:12:11)
Mar 31 18:32:33 sekt88 volumio[724]: at Socket.emit (events.js:315:20)
Mar 31 18:32:33 sekt88 volumio[724]: at emitReadable_ (internal/streams/readable.js:569:12)
Mar 31 18:32:33 sekt88 volumio[724]: at processTicksAndRejections (internal/process/task_queues.js:79:21) {
Mar 31 18:32:33 sekt88 volumio[724]: errno: -32,
Mar 31 18:32:33 sekt88 volumio[724]: code: 'EPIPE',
Mar 31 18:32:33 sekt88 volumio[724]: syscall: 'write'
Mar 31 18:32:33 sekt88 volumio[724]: }
Mar 31 18:32:33 sekt88 volumio[724]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 31 18:32:33 sekt88 sudo[2248]: pam_unix(sudo:session): session closed for user root
Mar 31 18:32:36 sekt88 sudo[2329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-31 18:31
Mar 31 18:32:36 sekt88 sudo[2329]: 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="9552505bba4239c163ac9ee7b0b87a56e0dd0574"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="3d3fc502273a5c173ba19f72c1a952bdb2bdd3b0"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 Feb 2024 06:28:23 PM CET"
VOLUMIO_VERSION="3.616"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="b343c71baf05cbc21bf1a530c8e51fc1"